2017-11-27 21:48:39,375 [salt.cli.daemons ][WARNING ][2031] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-27 21:48:56,797 [salt.state       ][ERROR   ][3601] No contents found in top file
2017-11-27 21:50:28,178 [salt.utils.parsers][WARNING ][2031] Minion received a SIGTERM. Exiting.
2017-11-27 21:54:56,273 [salt.cli.daemons ][WARNING ][3246] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-27 21:57:01,492 [py.warnings      ][WARNING ][13666] /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-27 21:59:45,591 [salt.loaded.int.module.cmdmod][ERROR   ][13666] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-27 21:59:45,592 [salt.loaded.int.module.cmdmod][ERROR   ][13666] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-27 21:59:49,987 [salt.loaded.int.module.cmdmod][ERROR   ][13666] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-27 21:59:49,987 [salt.loaded.int.module.cmdmod][ERROR   ][13666] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-27 21:59:54,377 [salt.loaded.int.module.cmdmod][ERROR   ][13666] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-27 21:59:54,377 [salt.loaded.int.module.cmdmod][ERROR   ][13666] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-27 21:59:59,316 [salt.loaded.int.module.cmdmod][ERROR   ][13666] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-27 21:59:59,317 [salt.loaded.int.module.cmdmod][ERROR   ][13666] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-27 22:00:03,682 [salt.loaded.int.module.cmdmod][ERROR   ][13666] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-27 22:00:03,683 [salt.loaded.int.module.cmdmod][ERROR   ][13666] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-27 22:00:07,207 [salt.loaded.int.module.cmdmod][ERROR   ][13666] 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-27 22:00:09,735 [salt.loaded.int.module.cmdmod][INFO    ][21203] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-27 22:00:09,742 [salt.loaded.int.module.cmdmod][INFO    ][21203] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-27 22:00:09,753 [salt.loaded.int.module.cmdmod][INFO    ][21203] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-11-27 22:00:09,762 [salt.utils.parsers][WARNING ][3246] Minion received a SIGTERM. Exiting.
2017-11-27 22:00:10,076 [salt.cli.daemons ][INFO    ][21278] Setting up the Salt Minion "kvm03.baremetal-mcp-ocata-ovs-ha.local"
2017-11-27 22:00:10,745 [salt.minion      ][INFO    ][21278] Creating minion process manager
2017-11-27 22:00:10,746 [salt.cli.daemons ][WARNING ][21278] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-27 22:00:10,746 [salt.cli.daemons ][INFO    ][21278] The Salt Minion is starting up
2017-11-27 22:00:10,746 [salt.minion      ][INFO    ][21278] Minion is starting as user 'root'
2017-11-27 22:00:10,747 [salt.utils.event ][INFO    ][21278] Starting pull socket on /var/run/salt/minion/minion_event_98ff1e569f_pull.ipc
2017-11-27 22:00:11,855 [salt.loaded.int.module.cmdmod][INFO    ][21278] Executing command ['date', '+%z'] in directory '/root'
2017-11-27 22:00:11,863 [salt.utils.schedule][INFO    ][21278] Updating job settings for scheduled job: __mine_interval
2017-11-27 22:00:11,866 [salt.minion      ][INFO    ][21278] Added mine.update to scheduler
2017-11-27 22:00:11,900 [salt.minion      ][INFO    ][21278] Minion is ready to receive requests!
2017-11-27 22:00:12,902 [salt.utils.schedule][INFO    ][21278] Running scheduled job: __mine_interval
2017-11-27 22:07:15,211 [salt.minion      ][INFO    ][21278] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171127220715201668
2017-11-27 22:07:15,221 [salt.minion      ][INFO    ][21496] Starting a new job with PID 21496
2017-11-27 22:07:17,460 [salt.state       ][INFO    ][21496] Loading fresh modules for state activity
2017-11-27 22:07:17,488 [salt.state       ][ERROR   ][21496] No contents found in top file
2017-11-27 22:07:17,488 [salt.utils.extmods][INFO    ][21496] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-11-27 22:07:17,491 [salt.utils.extmods][INFO    ][21496] Syncing beacons for environment 'base'
2017-11-27 22:07:17,491 [salt.utils.extmods][INFO    ][21496] Loading cache from salt://_beacons, for base)
2017-11-27 22:07:17,491 [salt.fileclient  ][INFO    ][21496] Caching directory '_beacons/' for environment 'base'
2017-11-27 22:07:17,524 [salt.utils.extmods][INFO    ][21496] Syncing modules for environment 'base'
2017-11-27 22:07:17,524 [salt.utils.extmods][INFO    ][21496] Loading cache from salt://_modules, for base)
2017-11-27 22:07:17,524 [salt.fileclient  ][INFO    ][21496] Caching directory '_modules/' for environment 'base'
2017-11-27 22:07:17,567 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_modules/avinetworks.py'
2017-11-27 22:07:17,576 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-11-27 22:07:17,585 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-11-27 22:07:17,596 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-11-27 22:07:17,605 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-11-27 22:07:17,615 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-11-27 22:07:17,625 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-11-27 22:07:17,634 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-11-27 22:07:17,644 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-11-27 22:07:17,653 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-11-27 22:07:17,875 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-11-27 22:07:17,888 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-11-27 22:07:17,899 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-11-27 22:07:17,911 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-11-27 22:07:17,927 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-11-27 22:07:17,935 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-11-27 22:07:17,944 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-11-27 22:07:17,953 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-11-27 22:07:17,962 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-11-27 22:07:17,971 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-11-27 22:07:17,980 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-11-27 22:07:17,998 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-11-27 22:07:18,462 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-11-27 22:07:18,473 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-11-27 22:07:18,481 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-11-27 22:07:18,494 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-11-27 22:07:18,503 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-11-27 22:07:18,515 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-11-27 22:07:18,527 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-11-27 22:07:18,547 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-11-27 22:07:18,558 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-11-27 22:07:18,568 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-11-27 22:07:18,577 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-11-27 22:07:18,590 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-11-27 22:07:18,593 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-11-27 22:07:18,594 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_modules/avinetworks.py' to '/var/cache/salt/minion/extmods/modules/avinetworks.py'
2017-11-27 22:07:18,594 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-11-27 22:07:18,594 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-11-27 22:07:18,594 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-11-27 22:07:18,595 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-11-27 22:07:18,595 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-11-27 22:07:18,595 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-11-27 22:07:18,595 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-11-27 22:07:18,596 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-11-27 22:07:18,596 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-11-27 22:07:18,596 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-11-27 22:07:18,597 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-11-27 22:07:18,597 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-11-27 22:07:18,597 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-11-27 22:07:18,597 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-11-27 22:07:18,597 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-11-27 22:07:18,598 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-11-27 22:07:18,598 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-11-27 22:07:18,598 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2017-11-27 22:07:18,599 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-11-27 22:07:18,599 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-11-27 22:07:18,599 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-11-27 22:07:18,599 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-11-27 22:07:18,600 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-11-27 22:07:18,600 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-11-27 22:07:18,600 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-11-27 22:07:18,601 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-11-27 22:07:18,601 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-11-27 22:07:18,601 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-11-27 22:07:18,601 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-11-27 22:07:18,601 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-11-27 22:07:18,602 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-11-27 22:07:18,602 [salt.utils.extmods][INFO    ][21496] 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-27 22:07:18,602 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-11-27 22:07:18,602 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-11-27 22:07:18,608 [salt.utils.extmods][INFO    ][21496] Syncing states for environment 'base'
2017-11-27 22:07:18,608 [salt.utils.extmods][INFO    ][21496] Loading cache from salt://_states, for base)
2017-11-27 22:07:18,608 [salt.fileclient  ][INFO    ][21496] Caching directory '_states/' for environment 'base'
2017-11-27 22:07:18,654 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_states/avinetworks.py'
2017-11-27 22:07:18,664 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-11-27 22:07:18,675 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-11-27 22:07:18,686 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-11-27 22:07:18,698 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-11-27 22:07:18,709 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-11-27 22:07:18,718 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-11-27 22:07:18,727 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-11-27 22:07:18,738 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-11-27 22:07:18,747 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_states/helm_repos.py'
2017-11-27 22:07:18,757 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-11-27 22:07:18,768 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-11-27 22:07:18,778 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-11-27 22:07:18,789 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_states/jenkins_globalenvprop.py'
2017-11-27 22:07:18,801 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-11-27 22:07:18,812 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-11-27 22:07:18,823 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-11-27 22:07:18,832 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-11-27 22:07:18,842 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-11-27 22:07:18,853 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-11-27 22:07:18,864 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-11-27 22:07:18,874 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-11-27 22:07:18,884 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-11-27 22:07:18,895 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-11-27 22:07:18,903 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-11-27 22:07:18,912 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-11-27 22:07:18,930 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-11-27 22:07:18,943 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-11-27 22:07:18,954 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-11-27 22:07:18,963 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-11-27 22:07:18,974 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-11-27 22:07:18,986 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-11-27 22:07:18,989 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_states/avinetworks.py' to '/var/cache/salt/minion/extmods/states/avinetworks.py'
2017-11-27 22:07:18,990 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-11-27 22:07:18,990 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-11-27 22:07:18,990 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-11-27 22:07:18,991 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-11-27 22:07:18,991 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-11-27 22:07:18,991 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-11-27 22:07:18,991 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-11-27 22:07:18,992 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-11-27 22:07:18,992 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_states/helm_repos.py' to '/var/cache/salt/minion/extmods/states/helm_repos.py'
2017-11-27 22:07:18,992 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-11-27 22:07:18,992 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-11-27 22:07:18,993 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-11-27 22:07:18,993 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_states/jenkins_globalenvprop.py' to '/var/cache/salt/minion/extmods/states/jenkins_globalenvprop.py'
2017-11-27 22:07:18,993 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-11-27 22:07:18,993 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-11-27 22:07:18,994 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-11-27 22:07:18,994 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-11-27 22:07:18,994 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-11-27 22:07:18,994 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-11-27 22:07:18,994 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-11-27 22:07:18,995 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-11-27 22:07:18,995 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-11-27 22:07:18,995 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-11-27 22:07:18,995 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-11-27 22:07:18,996 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-11-27 22:07:18,996 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-11-27 22:07:18,996 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-11-27 22:07:18,996 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-11-27 22:07:18,997 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-11-27 22:07:18,997 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-11-27 22:07:18,997 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-11-27 22:07:18,997 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-11-27 22:07:18,1000 [salt.utils.extmods][INFO    ][21496] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-11-27 22:07:19,003 [salt.utils.extmods][INFO    ][21496] Syncing sdb for environment 'base'
2017-11-27 22:07:19,003 [salt.utils.extmods][INFO    ][21496] Loading cache from salt://_sdb, for base)
2017-11-27 22:07:19,003 [salt.fileclient  ][INFO    ][21496] Caching directory '_sdb/' for environment 'base'
2017-11-27 22:07:19,039 [salt.utils.extmods][INFO    ][21496] Syncing grains for environment 'base'
2017-11-27 22:07:19,039 [salt.utils.extmods][INFO    ][21496] Loading cache from salt://_grains, for base)
2017-11-27 22:07:19,039 [salt.fileclient  ][INFO    ][21496] Caching directory '_grains/' for environment 'base'
2017-11-27 22:07:19,082 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-11-27 22:07:19,091 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-11-27 22:07:19,102 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-11-27 22:07:19,112 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-11-27 22:07:19,123 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-11-27 22:07:19,134 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-11-27 22:07:19,143 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-11-27 22:07:19,153 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-11-27 22:07:19,162 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-11-27 22:07:19,171 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-11-27 22:07:19,180 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-11-27 22:07:19,190 [salt.fileclient  ][INFO    ][21496] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-11-27 22:07:19,194 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-11-27 22:07:19,194 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-11-27 22:07:19,194 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-11-27 22:07:19,195 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-11-27 22:07:19,195 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-11-27 22:07:19,195 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-11-27 22:07:19,195 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-11-27 22:07:19,195 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-11-27 22:07:19,196 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-11-27 22:07:19,196 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-11-27 22:07:19,196 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-11-27 22:07:19,196 [salt.utils.extmods][INFO    ][21496] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-11-27 22:07:19,198 [salt.utils.extmods][INFO    ][21496] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-11-27 22:07:19,200 [salt.utils.extmods][INFO    ][21496] Syncing renderers for environment 'base'
2017-11-27 22:07:19,201 [salt.utils.extmods][INFO    ][21496] Loading cache from salt://_renderers, for base)
2017-11-27 22:07:19,201 [salt.fileclient  ][INFO    ][21496] Caching directory '_renderers/' for environment 'base'
2017-11-27 22:07:19,236 [salt.utils.extmods][INFO    ][21496] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-11-27 22:07:19,239 [salt.utils.extmods][INFO    ][21496] Syncing returners for environment 'base'
2017-11-27 22:07:19,239 [salt.utils.extmods][INFO    ][21496] Loading cache from salt://_returners, for base)
2017-11-27 22:07:19,239 [salt.fileclient  ][INFO    ][21496] Caching directory '_returners/' for environment 'base'
2017-11-27 22:07:19,275 [salt.utils.extmods][INFO    ][21496] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-11-27 22:07:19,277 [salt.utils.extmods][INFO    ][21496] Syncing output for environment 'base'
2017-11-27 22:07:19,277 [salt.utils.extmods][INFO    ][21496] Loading cache from salt://_output, for base)
2017-11-27 22:07:19,278 [salt.fileclient  ][INFO    ][21496] Caching directory '_output/' for environment 'base'
2017-11-27 22:07:19,312 [salt.utils.extmods][INFO    ][21496] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-11-27 22:07:19,315 [salt.utils.extmods][INFO    ][21496] Syncing utils for environment 'base'
2017-11-27 22:07:19,315 [salt.utils.extmods][INFO    ][21496] Loading cache from salt://_utils, for base)
2017-11-27 22:07:19,315 [salt.fileclient  ][INFO    ][21496] Caching directory '_utils/' for environment 'base'
2017-11-27 22:07:19,348 [salt.utils.extmods][INFO    ][21496] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-11-27 22:07:19,351 [salt.utils.extmods][INFO    ][21496] Syncing log_handlers for environment 'base'
2017-11-27 22:07:19,351 [salt.utils.extmods][INFO    ][21496] Loading cache from salt://_log_handlers, for base)
2017-11-27 22:07:19,351 [salt.fileclient  ][INFO    ][21496] Caching directory '_log_handlers/' for environment 'base'
2017-11-27 22:07:19,382 [salt.utils.extmods][INFO    ][21496] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-11-27 22:07:19,385 [salt.utils.extmods][INFO    ][21496] Syncing proxy for environment 'base'
2017-11-27 22:07:19,385 [salt.utils.extmods][INFO    ][21496] Loading cache from salt://_proxy, for base)
2017-11-27 22:07:19,385 [salt.fileclient  ][INFO    ][21496] Caching directory '_proxy/' for environment 'base'
2017-11-27 22:07:19,416 [salt.utils.extmods][INFO    ][21496] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-11-27 22:07:19,419 [salt.utils.extmods][INFO    ][21496] Syncing engines for environment 'base'
2017-11-27 22:07:19,419 [salt.utils.extmods][INFO    ][21496] Loading cache from salt://_engines, for base)
2017-11-27 22:07:19,419 [salt.fileclient  ][INFO    ][21496] Caching directory '_engines/' for environment 'base'
2017-11-27 22:07:19,459 [salt.minion      ][INFO    ][21496] Returning information for job: 20171127220715201668
2017-11-27 22:07:21,111 [salt.minion      ][INFO    ][21278] User sudo_ubuntu Executing command state.sls with jid 20171127220720754934
2017-11-27 22:07:21,119 [salt.minion      ][INFO    ][21592] Starting a new job with PID 21592
2017-11-27 22:07:21,749 [salt.state       ][INFO    ][21592] Loading fresh modules for state activity
2017-11-27 22:07:21,845 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-11-27 22:07:21,870 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-11-27 22:07:21,900 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-27 22:07:21,984 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-11-27 22:07:21,998 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-11-27 22:07:22,030 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-27 22:07:22,098 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-27 22:07:22,119 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-27 22:07:22,175 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-27 22:07:22,195 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-27 22:07:22,209 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-27 22:07:22,226 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-27 22:07:22,235 [salt.loaded.int.module.cmdmod][INFO    ][21592] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-27 22:07:22,259 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-27 22:07:22,277 [py.warnings      ][WARNING ][21592] /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-27 22:07:22,277 [salt.loaded.int.module.cmdmod][INFO    ][21592] Executing command 'salt-minion --version' in directory '/root'
2017-11-27 22:07:22,534 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-27 22:07:22,558 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-27 22:07:22,571 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-27 22:07:22,583 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-27 22:07:22,627 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-11-27 22:07:22,642 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-11-27 22:07:22,669 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-27 22:07:22,707 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-27 22:07:22,775 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-11-27 22:07:22,800 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-27 22:07:22,868 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-27 22:07:22,890 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-27 22:07:22,948 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-27 22:07:22,969 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-27 22:07:22,983 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-27 22:07:22,1000 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-27 22:07:23,008 [salt.loaded.int.module.cmdmod][INFO    ][21592] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-27 22:07:23,029 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-27 22:07:23,047 [salt.loaded.int.module.cmdmod][INFO    ][21592] Executing command 'salt-minion --version' in directory '/root'
2017-11-27 22:07:23,302 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-27 22:07:23,325 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-27 22:07:23,339 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-27 22:07:23,356 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-27 22:07:23,400 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-11-27 22:07:23,415 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-11-27 22:07:23,443 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-27 22:07:23,483 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-27 22:07:23,558 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-11-27 22:07:23,639 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-27 22:07:24,021 [salt.state       ][INFO    ][21592] Running state [salt-minion] at time 22:07:24.020507
2017-11-27 22:07:24,021 [salt.state       ][INFO    ][21592] Executing state pkg.installed for salt-minion
2017-11-27 22:07:24,021 [salt.loaded.int.module.cmdmod][INFO    ][21592] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-27 22:07:24,286 [salt.state       ][INFO    ][21592] Package salt-minion is already installed
2017-11-27 22:07:24,287 [salt.state       ][INFO    ][21592] Completed state [salt-minion] at time 22:07:24.286466 duration_in_ms=265.959
2017-11-27 22:07:24,287 [salt.state       ][INFO    ][21592] Running state [salt_minion_dependency_packages] at time 22:07:24.286765
2017-11-27 22:07:24,287 [salt.state       ][INFO    ][21592] Executing state pkg.installed for salt_minion_dependency_packages
2017-11-27 22:07:24,291 [salt.state       ][INFO    ][21592] All specified packages are already installed
2017-11-27 22:07:24,291 [salt.state       ][INFO    ][21592] Completed state [salt_minion_dependency_packages] at time 22:07:24.290882 duration_in_ms=4.117
2017-11-27 22:07:24,293 [salt.state       ][INFO    ][21592] Running state [/etc/salt/minion.d/minion.conf] at time 22:07:24.292545
2017-11-27 22:07:24,293 [salt.state       ][INFO    ][21592] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-11-27 22:07:24,319 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-11-27 22:07:24,378 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-27 22:07:24,431 [salt.fileclient  ][INFO    ][21592] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-27 22:07:24,478 [salt.state       ][INFO    ][21592] File /etc/salt/minion.d/minion.conf is in the correct state
2017-11-27 22:07:24,478 [salt.state       ][INFO    ][21592] Completed state [/etc/salt/minion.d/minion.conf] at time 22:07:24.477888 duration_in_ms=185.343
2017-11-27 22:07:24,478 [salt.state       ][INFO    ][21592] Running state [/etc/salt/minion.d/_virt.conf] at time 22:07:24.478291
2017-11-27 22:07:24,479 [salt.state       ][INFO    ][21592] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-11-27 22:07:24,479 [salt.state       ][INFO    ][21592] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-11-27 22:07:24,479 [salt.state       ][INFO    ][21592] Completed state [/etc/salt/minion.d/_virt.conf] at time 22:07:24.479369 duration_in_ms=1.078
2017-11-27 22:07:24,481 [salt.state       ][INFO    ][21592] Running state [salt-minion] at time 22:07:24.480966
2017-11-27 22:07:24,481 [salt.state       ][INFO    ][21592] Executing state service.running for salt-minion
2017-11-27 22:07:24,482 [salt.loaded.int.module.cmdmod][INFO    ][21592] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-27 22:07:24,497 [salt.loaded.int.module.cmdmod][INFO    ][21592] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-11-27 22:07:24,504 [salt.loaded.int.module.cmdmod][INFO    ][21592] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-27 22:07:24,512 [salt.state       ][INFO    ][21592] The service salt-minion is already running
2017-11-27 22:07:24,512 [salt.state       ][INFO    ][21592] Completed state [salt-minion] at time 22:07:24.511908 duration_in_ms=30.942
2017-11-27 22:07:24,514 [salt.state       ][INFO    ][21592] Running state [/etc/salt/grains.d] at time 22:07:24.513488
2017-11-27 22:07:24,514 [salt.state       ][INFO    ][21592] Executing state file.directory for /etc/salt/grains.d
2017-11-27 22:07:24,514 [salt.state       ][INFO    ][21592] Directory /etc/salt/grains.d is in the correct state
2017-11-27 22:07:24,515 [salt.state       ][INFO    ][21592] Completed state [/etc/salt/grains.d] at time 22:07:24.514544 duration_in_ms=1.057
2017-11-27 22:07:24,515 [salt.state       ][INFO    ][21592] Running state [/etc/salt/grains] at time 22:07:24.515085
2017-11-27 22:07:24,515 [salt.state       ][INFO    ][21592] Executing state file.managed for /etc/salt/grains
2017-11-27 22:07:24,516 [salt.state       ][INFO    ][21592] File /etc/salt/grains exists with proper permissions. No changes made.
2017-11-27 22:07:24,516 [salt.state       ][INFO    ][21592] Completed state [/etc/salt/grains] at time 22:07:24.515740 duration_in_ms=0.655
2017-11-27 22:07:24,516 [salt.state       ][INFO    ][21592] Running state [/etc/salt/grains.d/placeholder] at time 22:07:24.516067
2017-11-27 22:07:24,516 [salt.state       ][INFO    ][21592] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-11-27 22:07:24,517 [salt.state       ][INFO    ][21592] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-11-27 22:07:24,517 [salt.state       ][INFO    ][21592] Completed state [/etc/salt/grains.d/placeholder] at time 22:07:24.516666 duration_in_ms=0.599
2017-11-27 22:07:24,517 [salt.state       ][INFO    ][21592] Running state [/etc/salt/grains.d/sphinx] at time 22:07:24.517042
2017-11-27 22:07:24,517 [salt.state       ][INFO    ][21592] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-11-27 22:07:24,519 [salt.state       ][INFO    ][21592] File changed:
--- 
+++ 
@@ -49,7 +49,6 @@
               - 127.0.0.1
               - 192.168.10.143
               - 192.168.11.251
-              - 192.168.122.1
         system:
           name: System
           param:

2017-11-27 22:07:24,519 [salt.state       ][INFO    ][21592] Completed state [/etc/salt/grains.d/sphinx] at time 22:07:24.518876 duration_in_ms=1.834
2017-11-27 22:07:24,520 [salt.state       ][INFO    ][21592] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 22:07:24.519572
2017-11-27 22:07:24,520 [salt.state       ][INFO    ][21592] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-27 22:07:24,520 [salt.state       ][INFO    ][21592] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-27 22:07:24,520 [salt.state       ][INFO    ][21592] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 22:07:24.520069 duration_in_ms=0.497
2017-11-27 22:07:24,520 [salt.state       ][INFO    ][21592] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 22:07:24.520208
2017-11-27 22:07:24,520 [salt.state       ][INFO    ][21592] 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-27 22:07:24,521 [salt.loaded.int.module.cmdmod][INFO    ][21592] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-11-27 22:07:24,596 [salt.state       ][INFO    ][21592] {'pid': 21642, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-11-27 22:07:24,596 [salt.state       ][INFO    ][21592] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 22:07:24.595896 duration_in_ms=75.686
2017-11-27 22:07:24,596 [salt.state       ][INFO    ][21592] Running state [/etc/salt/grains.d/dns_records] at time 22:07:24.596465
2017-11-27 22:07:24,597 [salt.state       ][INFO    ][21592] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-11-27 22:07:24,598 [salt.state       ][INFO    ][21592] File /etc/salt/grains.d/dns_records is in the correct state
2017-11-27 22:07:24,598 [salt.state       ][INFO    ][21592] Completed state [/etc/salt/grains.d/dns_records] at time 22:07:24.597908 duration_in_ms=1.443
2017-11-27 22:07:24,599 [salt.state       ][INFO    ][21592] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 22:07:24.598798
2017-11-27 22:07:24,599 [salt.state       ][INFO    ][21592] 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-27 22:07:24,599 [salt.state       ][INFO    ][21592] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-11-27 22:07:24,599 [salt.state       ][INFO    ][21592] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 22:07:24.599402 duration_in_ms=0.603
2017-11-27 22:07:24,600 [salt.state       ][INFO    ][21592] Running state [/etc/salt/grains.d/salt] at time 22:07:24.599763
2017-11-27 22:07:24,600 [salt.state       ][INFO    ][21592] Executing state file.managed for /etc/salt/grains.d/salt
2017-11-27 22:07:24,601 [salt.state       ][INFO    ][21592] File /etc/salt/grains.d/salt is in the correct state
2017-11-27 22:07:24,601 [salt.state       ][INFO    ][21592] Completed state [/etc/salt/grains.d/salt] at time 22:07:24.600796 duration_in_ms=1.033
2017-11-27 22:07:24,602 [salt.state       ][INFO    ][21592] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 22:07:24.601514
2017-11-27 22:07:24,602 [salt.state       ][INFO    ][21592] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-27 22:07:24,602 [salt.state       ][INFO    ][21592] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-27 22:07:24,602 [salt.state       ][INFO    ][21592] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 22:07:24.602111 duration_in_ms=0.598
2017-11-27 22:07:24,604 [salt.state       ][INFO    ][21592] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 22:07:24.603729
2017-11-27 22:07:24,604 [salt.state       ][INFO    ][21592] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-27 22:07:24,604 [salt.state       ][INFO    ][21592] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-27 22:07:24,604 [salt.state       ][INFO    ][21592] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 22:07:24.604321 duration_in_ms=0.592
2017-11-27 22:07:24,605 [salt.state       ][INFO    ][21592] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 22:07:24.604477
2017-11-27 22:07:24,605 [salt.state       ][INFO    ][21592] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-27 22:07:24,606 [salt.loaded.int.module.cmdmod][INFO    ][21592] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-11-27 22:07:24,612 [salt.state       ][INFO    ][21592] {'pid': 21645, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-11-27 22:07:24,613 [salt.state       ][INFO    ][21592] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 22:07:24.612461 duration_in_ms=7.984
2017-11-27 22:07:24,613 [salt.state       ][INFO    ][21592] Running state [mine.update] at time 22:07:24.613112
2017-11-27 22:07:24,613 [salt.state       ][INFO    ][21592] Executing state module.wait for mine.update
2017-11-27 22:07:24,614 [salt.state       ][INFO    ][21592] No changes made for mine.update
2017-11-27 22:07:24,614 [salt.state       ][INFO    ][21592] Completed state [mine.update] at time 22:07:24.613713 duration_in_ms=0.601
2017-11-27 22:07:24,614 [salt.state       ][INFO    ][21592] Running state [mine.update] at time 22:07:24.613872
2017-11-27 22:07:24,614 [salt.state       ][INFO    ][21592] Executing state module.mod_watch for mine.update
2017-11-27 22:07:25,128 [salt.state       ][INFO    ][21592] {'ret': True}
2017-11-27 22:07:25,128 [salt.state       ][INFO    ][21592] Completed state [mine.update] at time 22:07:25.128133 duration_in_ms=514.249
2017-11-27 22:07:25,128 [salt.state       ][INFO    ][21592] Running state [ca-certificates] at time 22:07:25.128384
2017-11-27 22:07:25,129 [salt.state       ][INFO    ][21592] Executing state pkg.installed for ca-certificates
2017-11-27 22:07:25,133 [salt.state       ][INFO    ][21592] Package ca-certificates is already installed
2017-11-27 22:07:25,133 [salt.state       ][INFO    ][21592] Completed state [ca-certificates] at time 22:07:25.132724 duration_in_ms=4.34
2017-11-27 22:07:25,133 [salt.state       ][INFO    ][21592] Running state [update-ca-certificates] at time 22:07:25.133323
2017-11-27 22:07:25,134 [salt.state       ][INFO    ][21592] Executing state cmd.wait for update-ca-certificates
2017-11-27 22:07:25,134 [salt.state       ][INFO    ][21592] No changes made for update-ca-certificates
2017-11-27 22:07:25,134 [salt.state       ][INFO    ][21592] Completed state [update-ca-certificates] at time 22:07:25.133894 duration_in_ms=0.571
2017-11-27 22:07:25,134 [salt.state       ][INFO    ][21592] Running state [libvirt-dev] at time 22:07:25.134079
2017-11-27 22:07:25,134 [salt.state       ][INFO    ][21592] Executing state pkg.installed for libvirt-dev
2017-11-27 22:07:25,138 [salt.state       ][INFO    ][21592] Package libvirt-dev is already installed
2017-11-27 22:07:25,138 [salt.state       ][INFO    ][21592] Completed state [libvirt-dev] at time 22:07:25.138010 duration_in_ms=3.931
2017-11-27 22:07:25,138 [salt.state       ][INFO    ][21592] Running state [pkg-config] at time 22:07:25.138229
2017-11-27 22:07:25,138 [salt.state       ][INFO    ][21592] Executing state pkg.installed for pkg-config
2017-11-27 22:07:25,142 [salt.state       ][INFO    ][21592] Package pkg-config is already installed
2017-11-27 22:07:25,142 [salt.state       ][INFO    ][21592] Completed state [pkg-config] at time 22:07:25.142285 duration_in_ms=4.055
2017-11-27 22:07:25,143 [salt.state       ][INFO    ][21592] Running state [virtng.init] at time 22:07:25.142482
2017-11-27 22:07:25,143 [salt.state       ][INFO    ][21592] Executing state module.run for virtng.init
2017-11-27 22:07:25,236 [salt.loaded.int.module.cmdmod][INFO    ][21592] Executing command ['git', '--version'] in directory '/root'
2017-11-27 22:07:25,285 [salt.loaded.int.module.cmdmod][INFO    ][21592] Executing command 'virsh list --all --name| grep -E "^mdb03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-27 22:07:25,301 [salt.state       ][INFO    ][21592] unless execution succeeded
2017-11-27 22:07:25,301 [salt.state       ][INFO    ][21592] Completed state [virtng.init] at time 22:07:25.300862 duration_in_ms=158.38
2017-11-27 22:07:25,301 [salt.state       ][INFO    ][21592] Running state [virt.set_autostart] at time 22:07:25.301133
2017-11-27 22:07:25,301 [salt.state       ][INFO    ][21592] Executing state module.run for virt.set_autostart
2017-11-27 22:07:25,304 [salt.loaded.int.module.cmdmod][INFO    ][21592] Executing command 'virsh list --autostart --name| grep -E "^mdb03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-27 22:07:25,318 [salt.state       ][INFO    ][21592] unless execution succeeded
2017-11-27 22:07:25,318 [salt.state       ][INFO    ][21592] Completed state [virt.set_autostart] at time 22:07:25.318278 duration_in_ms=17.144
2017-11-27 22:07:25,319 [salt.state       ][INFO    ][21592] Running state [virtng.init] at time 22:07:25.318548
2017-11-27 22:07:25,319 [salt.state       ][INFO    ][21592] Executing state module.run for virtng.init
2017-11-27 22:07:25,321 [salt.loaded.int.module.cmdmod][INFO    ][21592] Executing command 'virsh list --all --name| grep -E "^dbs03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-27 22:07:25,336 [salt.state       ][INFO    ][21592] unless execution succeeded
2017-11-27 22:07:25,336 [salt.state       ][INFO    ][21592] Completed state [virtng.init] at time 22:07:25.335777 duration_in_ms=17.228
2017-11-27 22:07:25,336 [salt.state       ][INFO    ][21592] Running state [virt.set_autostart] at time 22:07:25.336009
2017-11-27 22:07:25,336 [salt.state       ][INFO    ][21592] Executing state module.run for virt.set_autostart
2017-11-27 22:07:25,339 [salt.loaded.int.module.cmdmod][INFO    ][21592] Executing command 'virsh list --autostart --name| grep -E "^dbs03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-27 22:07:25,355 [salt.state       ][INFO    ][21592] unless execution succeeded
2017-11-27 22:07:25,355 [salt.state       ][INFO    ][21592] Completed state [virt.set_autostart] at time 22:07:25.354968 duration_in_ms=18.958
2017-11-27 22:07:25,355 [salt.state       ][INFO    ][21592] Running state [virtng.init] at time 22:07:25.355283
2017-11-27 22:07:25,356 [salt.state       ][INFO    ][21592] Executing state module.run for virtng.init
2017-11-27 22:07:25,358 [salt.loaded.int.module.cmdmod][INFO    ][21592] Executing command 'virsh list --all --name| grep -E "^prx02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-27 22:07:25,372 [salt.state       ][INFO    ][21592] unless execution succeeded
2017-11-27 22:07:25,372 [salt.state       ][INFO    ][21592] Completed state [virtng.init] at time 22:07:25.372262 duration_in_ms=16.978
2017-11-27 22:07:25,373 [salt.state       ][INFO    ][21592] Running state [virt.set_autostart] at time 22:07:25.372485
2017-11-27 22:07:25,373 [salt.state       ][INFO    ][21592] Executing state module.run for virt.set_autostart
2017-11-27 22:07:25,375 [salt.loaded.int.module.cmdmod][INFO    ][21592] Executing command 'virsh list --autostart --name| grep -E "^prx02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-27 22:07:25,388 [salt.state       ][INFO    ][21592] unless execution succeeded
2017-11-27 22:07:25,388 [salt.state       ][INFO    ][21592] Completed state [virt.set_autostart] at time 22:07:25.388391 duration_in_ms=15.906
2017-11-27 22:07:25,389 [salt.state       ][INFO    ][21592] Running state [virtng.init] at time 22:07:25.388605
2017-11-27 22:07:25,389 [salt.state       ][INFO    ][21592] Executing state module.run for virtng.init
2017-11-27 22:07:25,391 [salt.loaded.int.module.cmdmod][INFO    ][21592] Executing command 'virsh list --all --name| grep -E "^msg03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-27 22:07:25,404 [salt.state       ][INFO    ][21592] unless execution succeeded
2017-11-27 22:07:25,404 [salt.state       ][INFO    ][21592] Completed state [virtng.init] at time 22:07:25.404166 duration_in_ms=15.561
2017-11-27 22:07:25,404 [salt.state       ][INFO    ][21592] Running state [virt.set_autostart] at time 22:07:25.404377
2017-11-27 22:07:25,405 [salt.state       ][INFO    ][21592] Executing state module.run for virt.set_autostart
2017-11-27 22:07:25,407 [salt.loaded.int.module.cmdmod][INFO    ][21592] Executing command 'virsh list --autostart --name| grep -E "^msg03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-27 22:07:25,422 [salt.state       ][INFO    ][21592] unless execution succeeded
2017-11-27 22:07:25,422 [salt.state       ][INFO    ][21592] Completed state [virt.set_autostart] at time 22:07:25.421952 duration_in_ms=17.574
2017-11-27 22:07:25,422 [salt.state       ][INFO    ][21592] Running state [virtng.init] at time 22:07:25.422292
2017-11-27 22:07:25,423 [salt.state       ][INFO    ][21592] Executing state module.run for virtng.init
2017-11-27 22:07:25,425 [salt.loaded.int.module.cmdmod][INFO    ][21592] Executing command 'virsh list --all --name| grep -E "^ctl03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-27 22:07:25,440 [salt.state       ][INFO    ][21592] unless execution succeeded
2017-11-27 22:07:25,440 [salt.state       ][INFO    ][21592] Completed state [virtng.init] at time 22:07:25.439756 duration_in_ms=17.465
2017-11-27 22:07:25,440 [salt.state       ][INFO    ][21592] Running state [virt.set_autostart] at time 22:07:25.439989
2017-11-27 22:07:25,440 [salt.state       ][INFO    ][21592] Executing state module.run for virt.set_autostart
2017-11-27 22:07:25,443 [salt.loaded.int.module.cmdmod][INFO    ][21592] Executing command 'virsh list --autostart --name| grep -E "^ctl03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-27 22:07:25,456 [salt.state       ][INFO    ][21592] unless execution succeeded
2017-11-27 22:07:25,456 [salt.state       ][INFO    ][21592] Completed state [virt.set_autostart] at time 22:07:25.455863 duration_in_ms=15.873
2017-11-27 22:07:25,459 [salt.minion      ][INFO    ][21592] Returning information for job: 20171127220720754934
2017-11-27 22:07:51,705 [salt.minion      ][INFO    ][21278] User sudo_ubuntu Executing command state.sls with jid 20171127220751693714
2017-11-27 22:07:51,714 [salt.minion      ][INFO    ][21703] Starting a new job with PID 21703
2017-11-27 22:07:53,994 [salt.state       ][INFO    ][21703] Loading fresh modules for state activity
2017-11-27 22:07:54,020 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-11-27 22:07:54,070 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-11-27 22:07:54,097 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-27 22:07:54,179 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-11-27 22:07:54,192 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-11-27 22:07:54,218 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-27 22:07:54,280 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-27 22:07:54,299 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-27 22:07:54,354 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-27 22:07:54,375 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-27 22:07:54,387 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-27 22:07:54,403 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-27 22:07:54,412 [salt.loaded.int.module.cmdmod][INFO    ][21703] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-27 22:07:54,436 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-27 22:07:54,455 [py.warnings      ][WARNING ][21703] /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-27 22:07:54,455 [salt.loaded.int.module.cmdmod][INFO    ][21703] Executing command 'salt-minion --version' in directory '/root'
2017-11-27 22:07:54,716 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-27 22:07:54,732 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-27 22:07:54,743 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-27 22:07:54,755 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-27 22:07:54,799 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-11-27 22:07:54,814 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-11-27 22:07:54,840 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-27 22:07:54,875 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-27 22:07:54,942 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-11-27 22:07:54,967 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-27 22:07:55,032 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-27 22:07:55,054 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-27 22:07:55,111 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-27 22:07:55,131 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-27 22:07:55,147 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-27 22:07:55,164 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-27 22:07:55,172 [salt.loaded.int.module.cmdmod][INFO    ][21703] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-27 22:07:55,195 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-27 22:07:55,213 [salt.loaded.int.module.cmdmod][INFO    ][21703] Executing command 'salt-minion --version' in directory '/root'
2017-11-27 22:07:55,471 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-27 22:07:55,491 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-27 22:07:55,503 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-27 22:07:55,516 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-27 22:07:55,559 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-11-27 22:07:55,574 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-11-27 22:07:55,600 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-27 22:07:55,636 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-27 22:07:55,713 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-11-27 22:07:55,787 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-27 22:07:56,125 [salt.state       ][INFO    ][21703] Running state [salt-minion] at time 22:07:56.124738
2017-11-27 22:07:56,125 [salt.state       ][INFO    ][21703] Executing state pkg.installed for salt-minion
2017-11-27 22:07:56,126 [salt.loaded.int.module.cmdmod][INFO    ][21703] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-27 22:07:56,391 [salt.state       ][INFO    ][21703] Package salt-minion is already installed
2017-11-27 22:07:56,391 [salt.state       ][INFO    ][21703] Completed state [salt-minion] at time 22:07:56.390790 duration_in_ms=266.053
2017-11-27 22:07:56,391 [salt.state       ][INFO    ][21703] Running state [salt_minion_dependency_packages] at time 22:07:56.391066
2017-11-27 22:07:56,391 [salt.state       ][INFO    ][21703] Executing state pkg.installed for salt_minion_dependency_packages
2017-11-27 22:07:56,395 [salt.state       ][INFO    ][21703] All specified packages are already installed
2017-11-27 22:07:56,395 [salt.state       ][INFO    ][21703] Completed state [salt_minion_dependency_packages] at time 22:07:56.395167 duration_in_ms=4.1
2017-11-27 22:07:56,397 [salt.state       ][INFO    ][21703] Running state [/etc/salt/minion.d/minion.conf] at time 22:07:56.396814
2017-11-27 22:07:56,397 [salt.state       ][INFO    ][21703] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-11-27 22:07:56,420 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-11-27 22:07:56,479 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-27 22:07:56,533 [salt.fileclient  ][INFO    ][21703] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-27 22:07:56,579 [salt.state       ][INFO    ][21703] File /etc/salt/minion.d/minion.conf is in the correct state
2017-11-27 22:07:56,580 [salt.state       ][INFO    ][21703] Completed state [/etc/salt/minion.d/minion.conf] at time 22:07:56.579530 duration_in_ms=182.716
2017-11-27 22:07:56,580 [salt.state       ][INFO    ][21703] Running state [/etc/salt/minion.d/_virt.conf] at time 22:07:56.579907
2017-11-27 22:07:56,580 [salt.state       ][INFO    ][21703] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-11-27 22:07:56,581 [salt.state       ][INFO    ][21703] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-11-27 22:07:56,581 [salt.state       ][INFO    ][21703] Completed state [/etc/salt/minion.d/_virt.conf] at time 22:07:56.580956 duration_in_ms=1.049
2017-11-27 22:07:56,583 [salt.state       ][INFO    ][21703] Running state [salt-minion] at time 22:07:56.582618
2017-11-27 22:07:56,583 [salt.state       ][INFO    ][21703] Executing state service.running for salt-minion
2017-11-27 22:07:56,583 [salt.loaded.int.module.cmdmod][INFO    ][21703] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-27 22:07:56,598 [salt.loaded.int.module.cmdmod][INFO    ][21703] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-11-27 22:07:56,605 [salt.loaded.int.module.cmdmod][INFO    ][21703] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-27 22:07:56,612 [salt.state       ][INFO    ][21703] The service salt-minion is already running
2017-11-27 22:07:56,612 [salt.state       ][INFO    ][21703] Completed state [salt-minion] at time 22:07:56.612284 duration_in_ms=29.666
2017-11-27 22:07:56,614 [salt.state       ][INFO    ][21703] Running state [/etc/salt/grains.d] at time 22:07:56.613744
2017-11-27 22:07:56,614 [salt.state       ][INFO    ][21703] Executing state file.directory for /etc/salt/grains.d
2017-11-27 22:07:56,615 [salt.state       ][INFO    ][21703] Directory /etc/salt/grains.d is in the correct state
2017-11-27 22:07:56,615 [salt.state       ][INFO    ][21703] Completed state [/etc/salt/grains.d] at time 22:07:56.614840 duration_in_ms=1.096
2017-11-27 22:07:56,615 [salt.state       ][INFO    ][21703] Running state [/etc/salt/grains] at time 22:07:56.615398
2017-11-27 22:07:56,616 [salt.state       ][INFO    ][21703] Executing state file.managed for /etc/salt/grains
2017-11-27 22:07:56,616 [salt.state       ][INFO    ][21703] File /etc/salt/grains exists with proper permissions. No changes made.
2017-11-27 22:07:56,616 [salt.state       ][INFO    ][21703] Completed state [/etc/salt/grains] at time 22:07:56.616147 duration_in_ms=0.748
2017-11-27 22:07:56,617 [salt.state       ][INFO    ][21703] Running state [/etc/salt/grains.d/placeholder] at time 22:07:56.616506
2017-11-27 22:07:56,617 [salt.state       ][INFO    ][21703] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-11-27 22:07:56,617 [salt.state       ][INFO    ][21703] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-11-27 22:07:56,617 [salt.state       ][INFO    ][21703] Completed state [/etc/salt/grains.d/placeholder] at time 22:07:56.617241 duration_in_ms=0.735
2017-11-27 22:07:56,618 [salt.state       ][INFO    ][21703] Running state [/etc/salt/grains.d/sphinx] at time 22:07:56.617603
2017-11-27 22:07:56,618 [salt.state       ][INFO    ][21703] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-11-27 22:07:56,619 [salt.state       ][INFO    ][21703] File /etc/salt/grains.d/sphinx is in the correct state
2017-11-27 22:07:56,619 [salt.state       ][INFO    ][21703] Completed state [/etc/salt/grains.d/sphinx] at time 22:07:56.618748 duration_in_ms=1.144
2017-11-27 22:07:56,620 [salt.state       ][INFO    ][21703] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 22:07:56.619477
2017-11-27 22:07:56,620 [salt.state       ][INFO    ][21703] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-27 22:07:56,620 [salt.state       ][INFO    ][21703] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-27 22:07:56,620 [salt.state       ][INFO    ][21703] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 22:07:56.620052 duration_in_ms=0.575
2017-11-27 22:07:56,620 [salt.state       ][INFO    ][21703] Running state [/etc/salt/grains.d/dns_records] at time 22:07:56.620402
2017-11-27 22:07:56,621 [salt.state       ][INFO    ][21703] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-11-27 22:07:56,621 [salt.state       ][INFO    ][21703] File /etc/salt/grains.d/dns_records is in the correct state
2017-11-27 22:07:56,621 [salt.state       ][INFO    ][21703] Completed state [/etc/salt/grains.d/dns_records] at time 22:07:56.621382 duration_in_ms=0.98
2017-11-27 22:07:56,622 [salt.state       ][INFO    ][21703] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 22:07:56.622158
2017-11-27 22:07:56,622 [salt.state       ][INFO    ][21703] 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-27 22:07:56,623 [salt.state       ][INFO    ][21703] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-11-27 22:07:56,623 [salt.state       ][INFO    ][21703] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 22:07:56.622748 duration_in_ms=0.59
2017-11-27 22:07:56,623 [salt.state       ][INFO    ][21703] Running state [/etc/salt/grains.d/salt] at time 22:07:56.623101
2017-11-27 22:07:56,623 [salt.state       ][INFO    ][21703] Executing state file.managed for /etc/salt/grains.d/salt
2017-11-27 22:07:56,624 [salt.state       ][INFO    ][21703] File /etc/salt/grains.d/salt is in the correct state
2017-11-27 22:07:56,624 [salt.state       ][INFO    ][21703] Completed state [/etc/salt/grains.d/salt] at time 22:07:56.624091 duration_in_ms=0.989
2017-11-27 22:07:56,625 [salt.state       ][INFO    ][21703] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 22:07:56.624783
2017-11-27 22:07:56,625 [salt.state       ][INFO    ][21703] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-27 22:07:56,625 [salt.state       ][INFO    ][21703] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-27 22:07:56,625 [salt.state       ][INFO    ][21703] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 22:07:56.625331 duration_in_ms=0.548
2017-11-27 22:07:56,627 [salt.state       ][INFO    ][21703] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 22:07:56.626951
2017-11-27 22:07:56,627 [salt.state       ][INFO    ][21703] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-27 22:07:56,627 [salt.state       ][INFO    ][21703] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-27 22:07:56,628 [salt.state       ][INFO    ][21703] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 22:07:56.627541 duration_in_ms=0.591
2017-11-27 22:07:56,628 [salt.state       ][INFO    ][21703] Running state [mine.update] at time 22:07:56.628057
2017-11-27 22:07:56,628 [salt.state       ][INFO    ][21703] Executing state module.wait for mine.update
2017-11-27 22:07:56,628 [salt.state       ][INFO    ][21703] No changes made for mine.update
2017-11-27 22:07:56,629 [salt.state       ][INFO    ][21703] Completed state [mine.update] at time 22:07:56.628579 duration_in_ms=0.523
2017-11-27 22:07:56,629 [salt.state       ][INFO    ][21703] Running state [ca-certificates] at time 22:07:56.628748
2017-11-27 22:07:56,629 [salt.state       ][INFO    ][21703] Executing state pkg.installed for ca-certificates
2017-11-27 22:07:56,633 [salt.state       ][INFO    ][21703] Package ca-certificates is already installed
2017-11-27 22:07:56,633 [salt.state       ][INFO    ][21703] Completed state [ca-certificates] at time 22:07:56.632887 duration_in_ms=4.138
2017-11-27 22:07:56,633 [salt.state       ][INFO    ][21703] Running state [update-ca-certificates] at time 22:07:56.633453
2017-11-27 22:07:56,634 [salt.state       ][INFO    ][21703] Executing state cmd.wait for update-ca-certificates
2017-11-27 22:07:56,634 [salt.state       ][INFO    ][21703] No changes made for update-ca-certificates
2017-11-27 22:07:56,634 [salt.state       ][INFO    ][21703] Completed state [update-ca-certificates] at time 22:07:56.634011 duration_in_ms=0.558
2017-11-27 22:07:56,634 [salt.state       ][INFO    ][21703] Running state [libvirt-dev] at time 22:07:56.634214
2017-11-27 22:07:56,634 [salt.state       ][INFO    ][21703] Executing state pkg.installed for libvirt-dev
2017-11-27 22:07:56,638 [salt.state       ][INFO    ][21703] Package libvirt-dev is already installed
2017-11-27 22:07:56,638 [salt.state       ][INFO    ][21703] Completed state [libvirt-dev] at time 22:07:56.638180 duration_in_ms=3.966
2017-11-27 22:07:56,638 [salt.state       ][INFO    ][21703] Running state [pkg-config] at time 22:07:56.638387
2017-11-27 22:07:56,639 [salt.state       ][INFO    ][21703] Executing state pkg.installed for pkg-config
2017-11-27 22:07:56,642 [salt.state       ][INFO    ][21703] Package pkg-config is already installed
2017-11-27 22:07:56,642 [salt.state       ][INFO    ][21703] Completed state [pkg-config] at time 22:07:56.642418 duration_in_ms=4.031
2017-11-27 22:07:56,643 [salt.state       ][INFO    ][21703] Running state [virtng.init] at time 22:07:56.642604
2017-11-27 22:07:56,643 [salt.state       ][INFO    ][21703] Executing state module.run for virtng.init
2017-11-27 22:07:56,735 [salt.loaded.int.module.cmdmod][INFO    ][21703] Executing command ['git', '--version'] in directory '/root'
2017-11-27 22:07:56,777 [salt.loaded.int.module.cmdmod][INFO    ][21703] Executing command 'virsh list --all --name| grep -E "^mdb03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-27 22:07:56,794 [salt.state       ][INFO    ][21703] unless execution succeeded
2017-11-27 22:07:56,795 [salt.state       ][INFO    ][21703] Completed state [virtng.init] at time 22:07:56.794748 duration_in_ms=152.143
2017-11-27 22:07:56,795 [salt.state       ][INFO    ][21703] Running state [virt.set_autostart] at time 22:07:56.795100
2017-11-27 22:07:56,795 [salt.state       ][INFO    ][21703] Executing state module.run for virt.set_autostart
2017-11-27 22:07:56,798 [salt.loaded.int.module.cmdmod][INFO    ][21703] Executing command 'virsh list --autostart --name| grep -E "^mdb03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-27 22:07:56,813 [salt.state       ][INFO    ][21703] unless execution succeeded
2017-11-27 22:07:56,814 [salt.state       ][INFO    ][21703] Completed state [virt.set_autostart] at time 22:07:56.813682 duration_in_ms=18.582
2017-11-27 22:07:56,814 [salt.state       ][INFO    ][21703] Running state [virtng.init] at time 22:07:56.813922
2017-11-27 22:07:56,814 [salt.state       ][INFO    ][21703] Executing state module.run for virtng.init
2017-11-27 22:07:56,817 [salt.loaded.int.module.cmdmod][INFO    ][21703] Executing command 'virsh list --all --name| grep -E "^dbs03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-27 22:07:56,831 [salt.state       ][INFO    ][21703] unless execution succeeded
2017-11-27 22:07:56,831 [salt.state       ][INFO    ][21703] Completed state [virtng.init] at time 22:07:56.831193 duration_in_ms=17.27
2017-11-27 22:07:56,831 [salt.state       ][INFO    ][21703] Running state [virt.set_autostart] at time 22:07:56.831433
2017-11-27 22:07:56,832 [salt.state       ][INFO    ][21703] Executing state module.run for virt.set_autostart
2017-11-27 22:07:56,834 [salt.loaded.int.module.cmdmod][INFO    ][21703] Executing command 'virsh list --autostart --name| grep -E "^dbs03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-27 22:07:56,849 [salt.state       ][INFO    ][21703] unless execution succeeded
2017-11-27 22:07:56,849 [salt.state       ][INFO    ][21703] Completed state [virt.set_autostart] at time 22:07:56.848822 duration_in_ms=17.388
2017-11-27 22:07:56,849 [salt.state       ][INFO    ][21703] Running state [virtng.init] at time 22:07:56.849053
2017-11-27 22:07:56,849 [salt.state       ][INFO    ][21703] Executing state module.run for virtng.init
2017-11-27 22:07:56,852 [salt.loaded.int.module.cmdmod][INFO    ][21703] Executing command 'virsh list --all --name| grep -E "^prx02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-27 22:07:56,866 [salt.state       ][INFO    ][21703] unless execution succeeded
2017-11-27 22:07:56,866 [salt.state       ][INFO    ][21703] Completed state [virtng.init] at time 22:07:56.866269 duration_in_ms=17.216
2017-11-27 22:07:56,867 [salt.state       ][INFO    ][21703] Running state [virt.set_autostart] at time 22:07:56.866537
2017-11-27 22:07:56,867 [salt.state       ][INFO    ][21703] Executing state module.run for virt.set_autostart
2017-11-27 22:07:56,869 [salt.loaded.int.module.cmdmod][INFO    ][21703] Executing command 'virsh list --autostart --name| grep -E "^prx02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-27 22:07:56,884 [salt.state       ][INFO    ][21703] unless execution succeeded
2017-11-27 22:07:56,884 [salt.state       ][INFO    ][21703] Completed state [virt.set_autostart] at time 22:07:56.883733 duration_in_ms=17.196
2017-11-27 22:07:56,884 [salt.state       ][INFO    ][21703] Running state [virtng.init] at time 22:07:56.883959
2017-11-27 22:07:56,884 [salt.state       ][INFO    ][21703] Executing state module.run for virtng.init
2017-11-27 22:07:56,887 [salt.loaded.int.module.cmdmod][INFO    ][21703] Executing command 'virsh list --all --name| grep -E "^msg03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-27 22:07:56,901 [salt.state       ][INFO    ][21703] unless execution succeeded
2017-11-27 22:07:56,901 [salt.state       ][INFO    ][21703] Completed state [virtng.init] at time 22:07:56.900954 duration_in_ms=16.994
2017-11-27 22:07:56,901 [salt.state       ][INFO    ][21703] Running state [virt.set_autostart] at time 22:07:56.901220
2017-11-27 22:07:56,901 [salt.state       ][INFO    ][21703] Executing state module.run for virt.set_autostart
2017-11-27 22:07:56,904 [salt.loaded.int.module.cmdmod][INFO    ][21703] Executing command 'virsh list --autostart --name| grep -E "^msg03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-27 22:07:56,919 [salt.state       ][INFO    ][21703] unless execution succeeded
2017-11-27 22:07:56,919 [salt.state       ][INFO    ][21703] Completed state [virt.set_autostart] at time 22:07:56.918820 duration_in_ms=17.6
2017-11-27 22:07:56,919 [salt.state       ][INFO    ][21703] Running state [virtng.init] at time 22:07:56.919053
2017-11-27 22:07:56,919 [salt.state       ][INFO    ][21703] Executing state module.run for virtng.init
2017-11-27 22:07:56,922 [salt.loaded.int.module.cmdmod][INFO    ][21703] Executing command 'virsh list --all --name| grep -E "^ctl03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-27 22:07:56,936 [salt.state       ][INFO    ][21703] unless execution succeeded
2017-11-27 22:07:56,936 [salt.state       ][INFO    ][21703] Completed state [virtng.init] at time 22:07:56.935765 duration_in_ms=16.712
2017-11-27 22:07:56,936 [salt.state       ][INFO    ][21703] Running state [virt.set_autostart] at time 22:07:56.936012
2017-11-27 22:07:56,936 [salt.state       ][INFO    ][21703] Executing state module.run for virt.set_autostart
2017-11-27 22:07:56,939 [salt.loaded.int.module.cmdmod][INFO    ][21703] Executing command 'virsh list --autostart --name| grep -E "^ctl03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-27 22:07:56,953 [salt.state       ][INFO    ][21703] unless execution succeeded
2017-11-27 22:07:56,953 [salt.state       ][INFO    ][21703] Completed state [virt.set_autostart] at time 22:07:56.953166 duration_in_ms=17.153
2017-11-27 22:07:56,956 [salt.minion      ][INFO    ][21703] Returning information for job: 20171127220751693714
2017-11-27 22:08:19,100 [salt.minion      ][INFO    ][21278] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171127220819088456
2017-11-27 22:08:19,111 [salt.minion      ][INFO    ][21815] Starting a new job with PID 21815
2017-11-27 22:08:22,480 [salt.state       ][INFO    ][21815] Loading fresh modules for state activity
2017-11-27 22:08:22,505 [salt.state       ][ERROR   ][21815] No contents found in top file
2017-11-27 22:08:22,506 [salt.utils.extmods][INFO    ][21815] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-11-27 22:08:22,509 [salt.utils.extmods][INFO    ][21815] Syncing beacons for environment 'base'
2017-11-27 22:08:22,510 [salt.utils.extmods][INFO    ][21815] Loading cache from salt://_beacons, for base)
2017-11-27 22:08:22,510 [salt.fileclient  ][INFO    ][21815] Caching directory '_beacons/' for environment 'base'
2017-11-27 22:08:22,545 [salt.utils.extmods][INFO    ][21815] Syncing modules for environment 'base'
2017-11-27 22:08:22,545 [salt.utils.extmods][INFO    ][21815] Loading cache from salt://_modules, for base)
2017-11-27 22:08:22,545 [salt.fileclient  ][INFO    ][21815] Caching directory '_modules/' for environment 'base'
2017-11-27 22:08:22,598 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_modules/avinetworks.py'
2017-11-27 22:08:22,607 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-11-27 22:08:22,615 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-11-27 22:08:22,626 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-11-27 22:08:23,418 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-11-27 22:08:24,059 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-11-27 22:08:24,073 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-11-27 22:08:24,084 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-11-27 22:08:24,103 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-11-27 22:08:24,112 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-11-27 22:08:24,124 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-11-27 22:08:24,140 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-11-27 22:08:24,155 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-11-27 22:08:24,177 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-11-27 22:08:24,216 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-11-27 22:08:24,238 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-11-27 22:08:24,260 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-11-27 22:08:24,275 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-11-27 22:08:24,301 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-11-27 22:08:24,312 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-11-27 22:08:24,325 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-11-27 22:08:24,344 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-11-27 22:08:24,407 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-11-27 22:08:24,425 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-11-27 22:08:24,434 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-11-27 22:08:24,442 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-11-27 22:08:24,455 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-11-27 22:08:24,487 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-11-27 22:08:24,498 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-11-27 22:08:24,537 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-11-27 22:08:24,567 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-11-27 22:08:24,592 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-11-27 22:08:24,617 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-11-27 22:08:24,641 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-11-27 22:08:24,645 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-11-27 22:08:24,645 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_modules/avinetworks.py' to '/var/cache/salt/minion/extmods/modules/avinetworks.py'
2017-11-27 22:08:24,646 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-11-27 22:08:24,646 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-11-27 22:08:24,646 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-11-27 22:08:24,647 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-11-27 22:08:24,647 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-11-27 22:08:24,647 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-11-27 22:08:24,647 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-11-27 22:08:24,648 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-11-27 22:08:24,648 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-11-27 22:08:24,648 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-11-27 22:08:24,648 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-11-27 22:08:24,649 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-11-27 22:08:24,649 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-11-27 22:08:24,649 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-11-27 22:08:24,649 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-11-27 22:08:24,650 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-11-27 22:08:24,650 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-11-27 22:08:24,650 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2017-11-27 22:08:24,651 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-11-27 22:08:24,651 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-11-27 22:08:24,651 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-11-27 22:08:24,651 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-11-27 22:08:24,652 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-11-27 22:08:24,652 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-11-27 22:08:24,653 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-11-27 22:08:24,653 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-11-27 22:08:24,653 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-11-27 22:08:24,653 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-11-27 22:08:24,654 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-11-27 22:08:24,654 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-11-27 22:08:24,654 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-11-27 22:08:24,654 [salt.utils.extmods][INFO    ][21815] 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-27 22:08:24,655 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-11-27 22:08:24,655 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-11-27 22:08:24,661 [salt.utils.extmods][INFO    ][21815] Syncing states for environment 'base'
2017-11-27 22:08:24,661 [salt.utils.extmods][INFO    ][21815] Loading cache from salt://_states, for base)
2017-11-27 22:08:24,662 [salt.fileclient  ][INFO    ][21815] Caching directory '_states/' for environment 'base'
2017-11-27 22:08:24,727 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_states/avinetworks.py'
2017-11-27 22:08:24,742 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-11-27 22:08:24,767 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-11-27 22:08:24,782 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-11-27 22:08:24,795 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-11-27 22:08:24,807 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-11-27 22:08:24,827 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-11-27 22:08:24,839 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-11-27 22:08:24,850 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-11-27 22:08:24,867 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_states/helm_repos.py'
2017-11-27 22:08:24,880 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-11-27 22:08:24,932 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-11-27 22:08:24,952 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-11-27 22:08:24,967 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_states/jenkins_globalenvprop.py'
2017-11-27 22:08:24,981 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-11-27 22:08:24,996 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-11-27 22:08:25,008 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-11-27 22:08:25,024 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-11-27 22:08:25,038 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-11-27 22:08:25,052 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-11-27 22:08:25,066 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-11-27 22:08:25,082 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-11-27 22:08:25,094 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-11-27 22:08:25,107 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-11-27 22:08:25,124 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-11-27 22:08:25,142 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-11-27 22:08:25,166 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-11-27 22:08:25,183 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-11-27 22:08:25,198 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-11-27 22:08:25,210 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-11-27 22:08:25,221 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-11-27 22:08:25,236 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-11-27 22:08:25,241 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_states/avinetworks.py' to '/var/cache/salt/minion/extmods/states/avinetworks.py'
2017-11-27 22:08:25,241 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-11-27 22:08:25,241 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-11-27 22:08:25,242 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-11-27 22:08:25,242 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-11-27 22:08:25,242 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-11-27 22:08:25,243 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-11-27 22:08:25,243 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-11-27 22:08:25,243 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-11-27 22:08:25,243 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_states/helm_repos.py' to '/var/cache/salt/minion/extmods/states/helm_repos.py'
2017-11-27 22:08:25,244 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-11-27 22:08:25,244 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-11-27 22:08:25,244 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-11-27 22:08:25,244 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_states/jenkins_globalenvprop.py' to '/var/cache/salt/minion/extmods/states/jenkins_globalenvprop.py'
2017-11-27 22:08:25,245 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-11-27 22:08:25,245 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-11-27 22:08:25,245 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-11-27 22:08:25,245 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-11-27 22:08:25,246 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-11-27 22:08:25,246 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-11-27 22:08:25,246 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-11-27 22:08:25,246 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-11-27 22:08:25,247 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-11-27 22:08:25,247 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-11-27 22:08:25,247 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-11-27 22:08:25,247 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-11-27 22:08:25,248 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-11-27 22:08:25,248 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-11-27 22:08:25,248 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-11-27 22:08:25,248 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-11-27 22:08:25,249 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-11-27 22:08:25,249 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-11-27 22:08:25,249 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-11-27 22:08:25,252 [salt.utils.extmods][INFO    ][21815] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-11-27 22:08:25,255 [salt.utils.extmods][INFO    ][21815] Syncing sdb for environment 'base'
2017-11-27 22:08:25,255 [salt.utils.extmods][INFO    ][21815] Loading cache from salt://_sdb, for base)
2017-11-27 22:08:25,256 [salt.fileclient  ][INFO    ][21815] Caching directory '_sdb/' for environment 'base'
2017-11-27 22:08:25,337 [salt.utils.extmods][INFO    ][21815] Syncing grains for environment 'base'
2017-11-27 22:08:25,337 [salt.utils.extmods][INFO    ][21815] Loading cache from salt://_grains, for base)
2017-11-27 22:08:25,338 [salt.fileclient  ][INFO    ][21815] Caching directory '_grains/' for environment 'base'
2017-11-27 22:08:25,424 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-11-27 22:08:25,440 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-11-27 22:08:25,451 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-11-27 22:08:25,463 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-11-27 22:08:25,520 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-11-27 22:08:25,527 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-11-27 22:08:25,555 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-11-27 22:08:25,568 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-11-27 22:08:25,588 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-11-27 22:08:25,597 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-11-27 22:08:25,606 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-11-27 22:08:25,654 [salt.fileclient  ][INFO    ][21815] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-11-27 22:08:25,658 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-11-27 22:08:25,658 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-11-27 22:08:25,658 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-11-27 22:08:25,659 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-11-27 22:08:25,659 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-11-27 22:08:25,659 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-11-27 22:08:25,659 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-11-27 22:08:25,660 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-11-27 22:08:25,660 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-11-27 22:08:25,660 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-11-27 22:08:25,660 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-11-27 22:08:25,661 [salt.utils.extmods][INFO    ][21815] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-11-27 22:08:25,662 [salt.utils.extmods][INFO    ][21815] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-11-27 22:08:25,665 [salt.utils.extmods][INFO    ][21815] Syncing renderers for environment 'base'
2017-11-27 22:08:25,665 [salt.utils.extmods][INFO    ][21815] Loading cache from salt://_renderers, for base)
2017-11-27 22:08:25,665 [salt.fileclient  ][INFO    ][21815] Caching directory '_renderers/' for environment 'base'
2017-11-27 22:08:25,709 [salt.utils.extmods][INFO    ][21815] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-11-27 22:08:25,712 [salt.utils.extmods][INFO    ][21815] Syncing returners for environment 'base'
2017-11-27 22:08:25,712 [salt.utils.extmods][INFO    ][21815] Loading cache from salt://_returners, for base)
2017-11-27 22:08:25,712 [salt.fileclient  ][INFO    ][21815] Caching directory '_returners/' for environment 'base'
2017-11-27 22:08:25,763 [salt.utils.extmods][INFO    ][21815] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-11-27 22:08:25,766 [salt.utils.extmods][INFO    ][21815] Syncing output for environment 'base'
2017-11-27 22:08:25,766 [salt.utils.extmods][INFO    ][21815] Loading cache from salt://_output, for base)
2017-11-27 22:08:25,766 [salt.fileclient  ][INFO    ][21815] Caching directory '_output/' for environment 'base'
2017-11-27 22:08:25,810 [salt.utils.extmods][INFO    ][21815] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-11-27 22:08:25,813 [salt.utils.extmods][INFO    ][21815] Syncing utils for environment 'base'
2017-11-27 22:08:25,813 [salt.utils.extmods][INFO    ][21815] Loading cache from salt://_utils, for base)
2017-11-27 22:08:25,813 [salt.fileclient  ][INFO    ][21815] Caching directory '_utils/' for environment 'base'
2017-11-27 22:08:25,866 [salt.utils.extmods][INFO    ][21815] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-11-27 22:08:25,868 [salt.utils.extmods][INFO    ][21815] Syncing log_handlers for environment 'base'
2017-11-27 22:08:25,868 [salt.utils.extmods][INFO    ][21815] Loading cache from salt://_log_handlers, for base)
2017-11-27 22:08:25,869 [salt.fileclient  ][INFO    ][21815] Caching directory '_log_handlers/' for environment 'base'
2017-11-27 22:08:25,914 [salt.utils.extmods][INFO    ][21815] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-11-27 22:08:25,917 [salt.utils.extmods][INFO    ][21815] Syncing proxy for environment 'base'
2017-11-27 22:08:25,917 [salt.utils.extmods][INFO    ][21815] Loading cache from salt://_proxy, for base)
2017-11-27 22:08:25,917 [salt.fileclient  ][INFO    ][21815] Caching directory '_proxy/' for environment 'base'
2017-11-27 22:08:25,987 [salt.utils.extmods][INFO    ][21815] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-11-27 22:08:25,990 [salt.utils.extmods][INFO    ][21815] Syncing engines for environment 'base'
2017-11-27 22:08:25,990 [salt.utils.extmods][INFO    ][21815] Loading cache from salt://_engines, for base)
2017-11-27 22:08:25,991 [salt.fileclient  ][INFO    ][21815] Caching directory '_engines/' for environment 'base'
2017-11-27 22:08:26,051 [salt.minion      ][INFO    ][21815] Returning information for job: 20171127220819088456
2017-11-27 22:15:22,118 [salt.minion      ][INFO    ][21278] User sudo_ubuntu Executing command test.ping with jid 20171127221522110662
2017-11-27 22:15:22,130 [salt.minion      ][INFO    ][21970] Starting a new job with PID 21970
2017-11-27 22:15:22,166 [salt.minion      ][INFO    ][21970] Returning information for job: 20171127221522110662
2017-11-27 22:17:14,496 [salt.minion      ][INFO    ][21278] User sudo_ubuntu Executing command state.sls with jid 20171127221714486096
2017-11-27 22:17:14,506 [salt.minion      ][INFO    ][22018] Starting a new job with PID 22018
2017-11-27 22:17:15,083 [salt.state       ][INFO    ][22018] Loading fresh modules for state activity
2017-11-27 22:17:15,110 [salt.fileclient  ][INFO    ][22018] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-11-27 22:17:15,128 [salt.fileclient  ][INFO    ][22018] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-11-27 22:17:15,157 [salt.fileclient  ][INFO    ][22018] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-27 22:17:15,488 [salt.state       ][INFO    ][22018] Running state [lsof] at time 22:17:15.488301
2017-11-27 22:17:15,489 [salt.state       ][INFO    ][22018] Executing state pkg.installed for lsof
2017-11-27 22:17:15,489 [salt.loaded.int.module.cmdmod][INFO    ][22018] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-27 22:17:15,751 [salt.state       ][INFO    ][22018] Package lsof is already installed
2017-11-27 22:17:15,751 [salt.state       ][INFO    ][22018] Completed state [lsof] at time 22:17:15.751182 duration_in_ms=262.881
2017-11-27 22:17:15,751 [salt.state       ][INFO    ][22018] Running state [keepalived] at time 22:17:15.751457
2017-11-27 22:17:15,752 [salt.state       ][INFO    ][22018] Executing state pkg.installed for keepalived
2017-11-27 22:17:15,768 [salt.loaded.int.module.cmdmod][INFO    ][22018] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-11-27 22:17:17,280 [salt.loaded.int.module.cmdmod][INFO    ][22018] 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-27 22:17:19,999 [salt.loaded.int.module.cmdmod][INFO    ][22018] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-27 22:17:20,024 [salt.state       ][INFO    ][22018] 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-27 22:17:20,034 [salt.state       ][INFO    ][22018] Loading fresh modules for state activity
2017-11-27 22:17:20,050 [salt.state       ][INFO    ][22018] Completed state [keepalived] at time 22:17:20.050120 duration_in_ms=4298.663
2017-11-27 22:17:20,053 [salt.state       ][INFO    ][22018] Running state [/etc/keepalived/keepalived.conf] at time 22:17:20.052641
2017-11-27 22:17:20,053 [salt.state       ][INFO    ][22018] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-11-27 22:17:20,079 [salt.fileclient  ][INFO    ][22018] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-11-27 22:17:20,119 [salt.fileclient  ][INFO    ][22018] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-27 22:17:20,127 [salt.state       ][INFO    ][22018] File changed:
New file
2017-11-27 22:17:20,127 [salt.state       ][INFO    ][22018] Completed state [/etc/keepalived/keepalived.conf] at time 22:17:20.126832 duration_in_ms=74.191
2017-11-27 22:17:20,190 [salt.state       ][INFO    ][22018] Running state [keepalived] at time 22:17:20.190001
2017-11-27 22:17:20,190 [salt.state       ][INFO    ][22018] Executing state service.running for keepalived
2017-11-27 22:17:20,192 [salt.loaded.int.module.cmdmod][INFO    ][22018] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-11-27 22:17:20,201 [salt.loaded.int.module.cmdmod][INFO    ][22018] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-27 22:17:20,208 [salt.loaded.int.module.cmdmod][INFO    ][22018] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-27 22:17:20,216 [salt.loaded.int.module.cmdmod][INFO    ][22018] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-27 22:17:20,223 [salt.loaded.int.module.cmdmod][INFO    ][22018] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-11-27 22:17:20,252 [salt.loaded.int.module.cmdmod][INFO    ][22018] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-27 22:17:20,260 [salt.loaded.int.module.cmdmod][INFO    ][22018] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-27 22:17:20,266 [salt.loaded.int.module.cmdmod][INFO    ][22018] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-27 22:17:20,272 [salt.state       ][INFO    ][22018] {'keepalived': True}
2017-11-27 22:17:20,272 [salt.state       ][INFO    ][22018] Completed state [keepalived] at time 22:17:20.272343 duration_in_ms=82.342
2017-11-27 22:17:20,273 [salt.minion      ][INFO    ][22018] Returning information for job: 20171127221714486096
2017-11-27 22:17:40,057 [salt.minion      ][INFO    ][21278] User sudo_ubuntu Executing command pillar.get with jid 20171127221740049390
2017-11-27 22:17:40,070 [salt.minion      ][INFO    ][23430] Starting a new job with PID 23430
2017-11-27 22:17:40,075 [salt.minion      ][INFO    ][23430] Returning information for job: 20171127221740049390
2017-11-27 22:22:51,307 [salt.minion      ][INFO    ][21278] User sudo_ubuntu Executing command state.sls with jid 20171127222251300700
2017-11-27 22:22:51,317 [salt.minion      ][INFO    ][23508] Starting a new job with PID 23508
2017-11-27 22:22:53,552 [salt.state       ][INFO    ][23508] Loading fresh modules for state activity
2017-11-27 22:22:53,578 [salt.fileclient  ][INFO    ][23508] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-27 22:22:53,600 [salt.fileclient  ][INFO    ][23508] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-27 22:22:53,901 [salt.state       ][INFO    ][23508] Running state [attr] at time 22:22:53.900494
2017-11-27 22:22:53,901 [salt.state       ][INFO    ][23508] Executing state pkg.installed for attr
2017-11-27 22:22:53,901 [salt.loaded.int.module.cmdmod][INFO    ][23508] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-27 22:22:54,193 [salt.loaded.int.module.cmdmod][INFO    ][23508] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-11-27 22:22:55,625 [salt.loaded.int.module.cmdmod][INFO    ][23508] 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-27 22:22:57,174 [salt.loaded.int.module.cmdmod][INFO    ][23508] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-27 22:22:57,201 [salt.state       ][INFO    ][23508] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-11-27 22:22:57,212 [salt.state       ][INFO    ][23508] Loading fresh modules for state activity
2017-11-27 22:22:57,229 [salt.state       ][INFO    ][23508] Completed state [attr] at time 22:22:57.228487 duration_in_ms=3327.992
2017-11-27 22:22:57,235 [salt.state       ][INFO    ][23508] Running state [glusterfs-server] at time 22:22:57.234623
2017-11-27 22:22:57,235 [salt.state       ][INFO    ][23508] Executing state pkg.installed for glusterfs-server
2017-11-27 22:22:57,449 [salt.loaded.int.module.cmdmod][INFO    ][23508] 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-27 22:23:01,409 [salt.minion      ][INFO    ][21278] User sudo_ubuntu Executing command saltutil.find_job with jid 20171127222301397037
2017-11-27 22:23:01,419 [salt.minion      ][INFO    ][24330] Starting a new job with PID 24330
2017-11-27 22:23:01,432 [salt.minion      ][INFO    ][24330] Returning information for job: 20171127222301397037
2017-11-27 22:23:07,558 [salt.loaded.int.module.cmdmod][INFO    ][23508] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-27 22:23:07,587 [salt.state       ][INFO    ][23508] Made the following changes:
'keyutils' changed from 'absent' to '1.5.9-8ubuntu1'
'glusterfs-client' changed from 'absent' to '3.10.7-ubuntu1~xenial1'
'rpcbind' changed from 'absent' to '0.2.3-0.2'
'libpython2.7' changed from 'absent' to '2.7.12-1ubuntu0~16.04.1'
'nfs-common' changed from 'absent' to '1:1.2.8-9ubuntu12.1'
'librdmacm1' changed from 'absent' to '1.0.21-1'
'glusterfs-common' changed from 'absent' to '3.10.7-ubuntu1~xenial1'
'liburcu4' changed from 'absent' to '0.9.1-3'
'portmap' changed from 'absent' to '1'
'libnfsidmap2' changed from 'absent' to '0.25-5'
'libibverbs1' changed from 'absent' to '1.1.8-1.1ubuntu2'
'libtirpc1' changed from 'absent' to '0.2.5-1'
'nfs-client' changed from 'absent' to '1'
'glusterfs-server' changed from 'absent' to '3.10.7-ubuntu1~xenial1'

2017-11-27 22:23:07,597 [salt.state       ][INFO    ][23508] Loading fresh modules for state activity
2017-11-27 22:23:07,615 [salt.state       ][INFO    ][23508] Completed state [glusterfs-server] at time 22:23:07.614728 duration_in_ms=10380.104
2017-11-27 22:23:07,621 [salt.state       ][INFO    ][23508] Running state [bc] at time 22:23:07.620519
2017-11-27 22:23:07,621 [salt.state       ][INFO    ][23508] Executing state pkg.installed for bc
2017-11-27 22:23:07,914 [salt.loaded.int.module.cmdmod][INFO    ][23508] 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-27 22:23:09,339 [salt.loaded.int.module.cmdmod][INFO    ][23508] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-27 22:23:09,370 [salt.state       ][INFO    ][23508] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-11-27 22:23:09,381 [salt.state       ][INFO    ][23508] Loading fresh modules for state activity
2017-11-27 22:23:09,399 [salt.state       ][INFO    ][23508] Completed state [bc] at time 22:23:09.398723 duration_in_ms=1778.204
2017-11-27 22:23:09,473 [salt.state       ][INFO    ][23508] Running state [glusterfs-server] at time 22:23:09.473003
2017-11-27 22:23:09,473 [salt.state       ][INFO    ][23508] Executing state service.running for glusterfs-server
2017-11-27 22:23:09,475 [salt.loaded.int.module.cmdmod][INFO    ][23508] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-27 22:23:09,483 [salt.loaded.int.module.cmdmod][INFO    ][23508] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-27 22:23:09,489 [salt.loaded.int.module.cmdmod][INFO    ][23508] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-27 22:23:09,497 [salt.state       ][INFO    ][23508] The service glusterfs-server is already running
2017-11-27 22:23:09,497 [salt.state       ][INFO    ][23508] Completed state [glusterfs-server] at time 22:23:09.497376 duration_in_ms=24.373
2017-11-27 22:23:09,499 [salt.state       ][INFO    ][23508] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:23:09.499393
2017-11-27 22:23:09,500 [salt.state       ][INFO    ][23508] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-27 22:23:09,504 [salt.state       ][INFO    ][23508] File changed:
New file
2017-11-27 22:23:09,504 [salt.state       ][INFO    ][23508] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:23:09.504329 duration_in_ms=4.936
2017-11-27 22:23:09,505 [salt.state       ][INFO    ][23508] Running state [/srv/glusterfs/glance] at time 22:23:09.504523
2017-11-27 22:23:09,505 [salt.state       ][INFO    ][23508] Executing state file.directory for /srv/glusterfs/glance
2017-11-27 22:23:09,505 [salt.state       ][INFO    ][23508] {'/srv/glusterfs/glance': 'New Dir'}
2017-11-27 22:23:09,506 [salt.state       ][INFO    ][23508] Completed state [/srv/glusterfs/glance] at time 22:23:09.505528 duration_in_ms=1.004
2017-11-27 22:23:09,506 [salt.state       ][INFO    ][23508] Running state [/srv/glusterfs/keystone-keys] at time 22:23:09.505703
2017-11-27 22:23:09,506 [salt.state       ][INFO    ][23508] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-27 22:23:09,506 [salt.state       ][INFO    ][23508] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-11-27 22:23:09,507 [salt.state       ][INFO    ][23508] Completed state [/srv/glusterfs/keystone-keys] at time 22:23:09.506560 duration_in_ms=0.857
2017-11-27 22:23:09,507 [salt.state       ][INFO    ][23508] Running state [/srv/glusterfs/nova_instances] at time 22:23:09.506729
2017-11-27 22:23:09,507 [salt.state       ][INFO    ][23508] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-27 22:23:09,507 [salt.state       ][INFO    ][23508] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-11-27 22:23:09,507 [salt.state       ][INFO    ][23508] Completed state [/srv/glusterfs/nova_instances] at time 22:23:09.507469 duration_in_ms=0.74
2017-11-27 22:23:09,508 [salt.state       ][INFO    ][23508] Running state [/srv/glusterfs/keystone-credential-keys] at time 22:23:09.507631
2017-11-27 22:23:09,508 [salt.state       ][INFO    ][23508] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-27 22:23:09,508 [salt.state       ][INFO    ][23508] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-11-27 22:23:09,508 [salt.state       ][INFO    ][23508] Completed state [/srv/glusterfs/keystone-credential-keys] at time 22:23:09.508384 duration_in_ms=0.752
2017-11-27 22:23:09,509 [salt.minion      ][INFO    ][23508] Returning information for job: 20171127222251300700
2017-11-27 22:23:17,542 [salt.minion      ][INFO    ][21278] User sudo_ubuntu Executing command test.ping with jid 20171127222317535142
2017-11-27 22:23:17,553 [salt.minion      ][INFO    ][26279] Starting a new job with PID 26279
2017-11-27 22:23:17,588 [salt.minion      ][INFO    ][26279] Returning information for job: 20171127222317535142
2017-11-27 22:23:41,900 [salt.minion      ][INFO    ][21278] User sudo_ubuntu Executing command state.sls with jid 20171127222341891310
2017-11-27 22:23:41,910 [salt.minion      ][INFO    ][26913] Starting a new job with PID 26913
2017-11-27 22:23:44,091 [salt.state       ][INFO    ][26913] Loading fresh modules for state activity
2017-11-27 22:23:44,120 [salt.fileclient  ][INFO    ][26913] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-11-27 22:23:44,159 [salt.fileclient  ][INFO    ][26913] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-27 22:23:44,251 [salt.fileclient  ][INFO    ][26913] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-27 22:23:44,278 [salt.fileclient  ][INFO    ][26913] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-27 22:23:44,585 [salt.state       ][INFO    ][26913] Running state [attr] at time 22:23:44.584584
2017-11-27 22:23:44,585 [salt.state       ][INFO    ][26913] Executing state pkg.installed for attr
2017-11-27 22:23:44,585 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-27 22:23:44,858 [salt.state       ][INFO    ][26913] Package attr is already installed
2017-11-27 22:23:44,858 [salt.state       ][INFO    ][26913] Completed state [attr] at time 22:23:44.858259 duration_in_ms=273.675
2017-11-27 22:23:44,859 [salt.state       ][INFO    ][26913] Running state [glusterfs-server] at time 22:23:44.858506
2017-11-27 22:23:44,859 [salt.state       ][INFO    ][26913] Executing state pkg.installed for glusterfs-server
2017-11-27 22:23:44,863 [salt.state       ][INFO    ][26913] Package glusterfs-server is already installed
2017-11-27 22:23:44,863 [salt.state       ][INFO    ][26913] Completed state [glusterfs-server] at time 22:23:44.862656 duration_in_ms=4.15
2017-11-27 22:23:44,863 [salt.state       ][INFO    ][26913] Running state [bc] at time 22:23:44.862867
2017-11-27 22:23:44,863 [salt.state       ][INFO    ][26913] Executing state pkg.installed for bc
2017-11-27 22:23:44,867 [salt.state       ][INFO    ][26913] Package bc is already installed
2017-11-27 22:23:44,867 [salt.state       ][INFO    ][26913] Completed state [bc] at time 22:23:44.866975 duration_in_ms=4.108
2017-11-27 22:23:44,868 [salt.state       ][INFO    ][26913] Running state [glusterfs-server] at time 22:23:44.868024
2017-11-27 22:23:44,868 [salt.state       ][INFO    ][26913] Executing state service.running for glusterfs-server
2017-11-27 22:23:44,869 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-27 22:23:44,877 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-11-27 22:23:44,926 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-27 22:23:44,939 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-27 22:23:44,944 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-27 22:23:44,952 [salt.state       ][INFO    ][26913] The service glusterfs-server is already running
2017-11-27 22:23:44,952 [salt.state       ][INFO    ][26913] Completed state [glusterfs-server] at time 22:23:44.951727 duration_in_ms=83.703
2017-11-27 22:23:44,953 [salt.state       ][INFO    ][26913] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:23:44.953286
2017-11-27 22:23:44,954 [salt.state       ][INFO    ][26913] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-27 22:23:44,955 [salt.state       ][INFO    ][26913] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-27 22:23:44,956 [salt.state       ][INFO    ][26913] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:23:44.955597 duration_in_ms=2.311
2017-11-27 22:23:44,956 [salt.state       ][INFO    ][26913] Running state [/srv/glusterfs/glance] at time 22:23:44.955789
2017-11-27 22:23:44,956 [salt.state       ][INFO    ][26913] Executing state file.directory for /srv/glusterfs/glance
2017-11-27 22:23:44,956 [salt.state       ][INFO    ][26913] Directory /srv/glusterfs/glance is in the correct state
2017-11-27 22:23:44,957 [salt.state       ][INFO    ][26913] Completed state [/srv/glusterfs/glance] at time 22:23:44.956599 duration_in_ms=0.811
2017-11-27 22:23:44,957 [salt.state       ][INFO    ][26913] Running state [/srv/glusterfs/keystone-keys] at time 22:23:44.956788
2017-11-27 22:23:44,957 [salt.state       ][INFO    ][26913] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-27 22:23:44,957 [salt.state       ][INFO    ][26913] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-27 22:23:44,958 [salt.state       ][INFO    ][26913] Completed state [/srv/glusterfs/keystone-keys] at time 22:23:44.957526 duration_in_ms=0.738
2017-11-27 22:23:44,958 [salt.state       ][INFO    ][26913] Running state [/srv/glusterfs/nova_instances] at time 22:23:44.957716
2017-11-27 22:23:44,958 [salt.state       ][INFO    ][26913] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-27 22:23:44,958 [salt.state       ][INFO    ][26913] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-27 22:23:44,959 [salt.state       ][INFO    ][26913] Completed state [/srv/glusterfs/nova_instances] at time 22:23:44.958482 duration_in_ms=0.766
2017-11-27 22:23:44,959 [salt.state       ][INFO    ][26913] Running state [/srv/glusterfs/keystone-credential-keys] at time 22:23:44.958681
2017-11-27 22:23:44,959 [salt.state       ][INFO    ][26913] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-27 22:23:44,959 [salt.state       ][INFO    ][26913] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-27 22:23:44,959 [salt.state       ][INFO    ][26913] Completed state [/srv/glusterfs/keystone-credential-keys] at time 22:23:44.959413 duration_in_ms=0.731
2017-11-27 22:23:45,063 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command ['git', '--version'] in directory '/root'
2017-11-27 22:23:45,113 [salt.state       ][INFO    ][26913] Running state [sleep 5] at time 22:23:45.112559
2017-11-27 22:23:45,113 [salt.state       ][INFO    ][26913] Executing state cmd.wait for sleep 5
2017-11-27 22:23:45,113 [salt.state       ][INFO    ][26913] No changes made for sleep 5
2017-11-27 22:23:45,113 [salt.state       ][INFO    ][26913] Completed state [sleep 5] at time 22:23:45.113163 duration_in_ms=0.604
2017-11-27 22:23:45,114 [salt.state       ][INFO    ][26913] Running state [192.168.10.143] at time 22:23:45.113684
2017-11-27 22:23:45,114 [salt.state       ][INFO    ][26913] Executing state glusterfs.peered for 192.168.10.143
2017-11-27 22:23:45,114 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:45,122 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:45,177 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:45,185 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:45,241 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:45,249 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:45,304 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:45,311 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:45,364 [salt.state       ][INFO    ][26913] Peering with localhost is not needed
2017-11-27 22:23:45,365 [salt.state       ][INFO    ][26913] Completed state [192.168.10.143] at time 22:23:45.364708 duration_in_ms=251.024
2017-11-27 22:23:45,368 [salt.state       ][INFO    ][26913] Running state [192.168.10.142] at time 22:23:45.367759
2017-11-27 22:23:45,368 [salt.state       ][INFO    ][26913] Executing state glusterfs.peered for 192.168.10.142
2017-11-27 22:23:45,368 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:45,376 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:45,431 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:45,438 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:45,492 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:45,499 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:45,555 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:45,563 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:45,616 [salt.state       ][INFO    ][26913] {'new': {'192.168.10.141': [], 'kvm02.baremetal-mcp-ocata-ovs-ha.local': ['192.168.10.142']}, 'old': {'192.168.10.141': [], 'kvm02.baremetal-mcp-ocata-ovs-ha.local': []}}
2017-11-27 22:23:45,617 [salt.state       ][INFO    ][26913] Completed state [192.168.10.142] at time 22:23:45.616555 duration_in_ms=248.795
2017-11-27 22:23:45,620 [salt.state       ][INFO    ][26913] Running state [192.168.10.141] at time 22:23:45.619686
2017-11-27 22:23:45,620 [salt.state       ][INFO    ][26913] Executing state glusterfs.peered for 192.168.10.141
2017-11-27 22:23:45,620 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:45,628 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:45,683 [salt.state       ][INFO    ][26913] Host 192.168.10.141 already peered
2017-11-27 22:23:45,683 [salt.state       ][INFO    ][26913] Completed state [192.168.10.141] at time 22:23:45.682804 duration_in_ms=63.118
2017-11-27 22:23:45,684 [salt.state       ][INFO    ][26913] Running state [glance] at time 22:23:45.683830
2017-11-27 22:23:45,684 [salt.state       ][INFO    ][26913] Executing state glusterfs.created for glance
2017-11-27 22:23:45,685 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:45,692 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:45,746 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:45,753 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:45,814 [salt.state       ][INFO    ][26913] Volume glance already exists and is started.
2017-11-27 22:23:45,814 [salt.state       ][INFO    ][26913] Completed state [glance] at time 22:23:45.813915 duration_in_ms=130.084
2017-11-27 22:23:45,818 [salt.state       ][INFO    ][26913] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 22:23:45.818203
2017-11-27 22:23:45,818 [salt.state       ][INFO    ][26913] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-11-27 22:23:45,819 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-27 22:23:45,874 [salt.state       ][INFO    ][26913] unless execution succeeded
2017-11-27 22:23:45,875 [salt.state       ][INFO    ][26913] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 22:23:45.874454 duration_in_ms=56.251
2017-11-27 22:23:45,875 [salt.state       ][INFO    ][26913] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 22:23:45.875165
2017-11-27 22:23:45,875 [salt.state       ][INFO    ][26913] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-11-27 22:23:45,876 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-27 22:23:45,931 [salt.state       ][INFO    ][26913] unless execution succeeded
2017-11-27 22:23:45,931 [salt.state       ][INFO    ][26913] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 22:23:45.931446 duration_in_ms=56.28
2017-11-27 22:23:45,932 [salt.state       ][INFO    ][26913] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 22:23:45.931985
2017-11-27 22:23:45,932 [salt.state       ][INFO    ][26913] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-11-27 22:23:45,933 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-11-27 22:23:45,986 [salt.state       ][INFO    ][26913] unless execution succeeded
2017-11-27 22:23:45,987 [salt.state       ][INFO    ][26913] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 22:23:45.986655 duration_in_ms=54.67
2017-11-27 22:23:45,987 [salt.state       ][INFO    ][26913] Running state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 22:23:45.987268
2017-11-27 22:23:45,987 [salt.state       ][INFO    ][26913] Executing state cmd.run for gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'
2017-11-27 22:23:45,988 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster volume info 'glance' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-11-27 22:23:46,041 [salt.state       ][INFO    ][26913] unless execution succeeded
2017-11-27 22:23:46,041 [salt.state       ][INFO    ][26913] Completed state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 22:23:46.041138 duration_in_ms=53.87
2017-11-27 22:23:46,042 [salt.state       ][INFO    ][26913] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 22:23:46.041706
2017-11-27 22:23:46,042 [salt.state       ][INFO    ][26913] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-11-27 22:23:46,042 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-27 22:23:46,097 [salt.state       ][INFO    ][26913] unless execution succeeded
2017-11-27 22:23:46,097 [salt.state       ][INFO    ][26913] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 22:23:46.097235 duration_in_ms=55.529
2017-11-27 22:23:46,098 [salt.state       ][INFO    ][26913] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 22:23:46.097783
2017-11-27 22:23:46,098 [salt.state       ][INFO    ][26913] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-11-27 22:23:46,099 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-27 22:23:46,150 [salt.state       ][INFO    ][26913] unless execution succeeded
2017-11-27 22:23:46,150 [salt.state       ][INFO    ][26913] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 22:23:46.150181 duration_in_ms=52.398
2017-11-27 22:23:46,152 [salt.state       ][INFO    ][26913] Running state [glance] at time 22:23:46.151661
2017-11-27 22:23:46,152 [salt.state       ][INFO    ][26913] Executing state glusterfs.started for glance
2017-11-27 22:23:46,152 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:46,160 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:46,213 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:46,221 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:46,283 [salt.state       ][INFO    ][26913] Volume glance is already started
2017-11-27 22:23:46,283 [salt.state       ][INFO    ][26913] Completed state [glance] at time 22:23:46.282941 duration_in_ms=131.28
2017-11-27 22:23:46,285 [salt.state       ][INFO    ][26913] Running state [keystone-keys] at time 22:23:46.284719
2017-11-27 22:23:46,285 [salt.state       ][INFO    ][26913] Executing state glusterfs.created for keystone-keys
2017-11-27 22:23:46,286 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:46,294 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:46,349 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:46,355 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:46,414 [salt.state       ][INFO    ][26913] Volume keystone-keys already exists and is started.
2017-11-27 22:23:46,414 [salt.state       ][INFO    ][26913] Completed state [keystone-keys] at time 22:23:46.414250 duration_in_ms=129.53
2017-11-27 22:23:46,420 [salt.state       ][INFO    ][26913] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 22:23:46.419827
2017-11-27 22:23:46,420 [salt.state       ][INFO    ][26913] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-11-27 22:23:46,421 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-27 22:23:46,475 [salt.state       ][INFO    ][26913] unless execution succeeded
2017-11-27 22:23:46,476 [salt.state       ][INFO    ][26913] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 22:23:46.475694 duration_in_ms=55.866
2017-11-27 22:23:46,476 [salt.state       ][INFO    ][26913] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:23:46.476268
2017-11-27 22:23:46,477 [salt.state       ][INFO    ][26913] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-27 22:23:46,477 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-27 22:23:46,531 [salt.state       ][INFO    ][26913] unless execution succeeded
2017-11-27 22:23:46,531 [salt.state       ][INFO    ][26913] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:23:46.531003 duration_in_ms=54.734
2017-11-27 22:23:46,532 [salt.state       ][INFO    ][26913] Running state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 22:23:46.531608
2017-11-27 22:23:46,532 [salt.state       ][INFO    ][26913] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'
2017-11-27 22:23:46,532 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-11-27 22:23:46,587 [salt.state       ][INFO    ][26913] unless execution succeeded
2017-11-27 22:23:46,587 [salt.state       ][INFO    ][26913] Completed state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 22:23:46.586769 duration_in_ms=55.151
2017-11-27 22:23:46,587 [salt.state       ][INFO    ][26913] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:23:46.587454
2017-11-27 22:23:46,588 [salt.state       ][INFO    ][26913] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-27 22:23:46,588 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-27 22:23:46,642 [salt.state       ][INFO    ][26913] unless execution succeeded
2017-11-27 22:23:46,642 [salt.state       ][INFO    ][26913] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:23:46.641999 duration_in_ms=54.545
2017-11-27 22:23:46,643 [salt.state       ][INFO    ][26913] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 22:23:46.642738
2017-11-27 22:23:46,643 [salt.state       ][INFO    ][26913] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-11-27 22:23:46,644 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-27 22:23:46,697 [salt.state       ][INFO    ][26913] unless execution succeeded
2017-11-27 22:23:46,698 [salt.state       ][INFO    ][26913] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 22:23:46.697566 duration_in_ms=54.828
2017-11-27 22:23:46,698 [salt.state       ][INFO    ][26913] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 22:23:46.698234
2017-11-27 22:23:46,699 [salt.state       ][INFO    ][26913] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-11-27 22:23:46,699 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-27 22:23:46,753 [salt.state       ][INFO    ][26913] unless execution succeeded
2017-11-27 22:23:46,753 [salt.state       ][INFO    ][26913] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 22:23:46.752789 duration_in_ms=54.555
2017-11-27 22:23:46,755 [salt.state       ][INFO    ][26913] Running state [keystone-keys] at time 22:23:46.754467
2017-11-27 22:23:46,755 [salt.state       ][INFO    ][26913] Executing state glusterfs.started for keystone-keys
2017-11-27 22:23:46,755 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:46,764 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:46,817 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:46,825 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:46,885 [salt.state       ][INFO    ][26913] Volume keystone-keys is already started
2017-11-27 22:23:46,885 [salt.state       ][INFO    ][26913] Completed state [keystone-keys] at time 22:23:46.885206 duration_in_ms=130.737
2017-11-27 22:23:46,886 [salt.state       ][INFO    ][26913] Running state [nova_instances] at time 22:23:46.886469
2017-11-27 22:23:46,887 [salt.state       ][INFO    ][26913] Executing state glusterfs.created for nova_instances
2017-11-27 22:23:46,887 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:46,895 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:46,950 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:46,957 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:47,015 [salt.state       ][INFO    ][26913] Volume nova_instances already exists and is started.
2017-11-27 22:23:47,016 [salt.state       ][INFO    ][26913] Completed state [nova_instances] at time 22:23:47.015500 duration_in_ms=129.031
2017-11-27 22:23:47,020 [salt.state       ][INFO    ][26913] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 22:23:47.020140
2017-11-27 22:23:47,020 [salt.state       ][INFO    ][26913] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-11-27 22:23:47,021 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-27 22:23:47,075 [salt.state       ][INFO    ][26913] unless execution succeeded
2017-11-27 22:23:47,075 [salt.state       ][INFO    ][26913] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 22:23:47.075237 duration_in_ms=55.097
2017-11-27 22:23:47,076 [salt.state       ][INFO    ][26913] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 22:23:47.075920
2017-11-27 22:23:47,076 [salt.state       ][INFO    ][26913] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'
2017-11-27 22:23:47,077 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-27 22:23:47,131 [salt.state       ][INFO    ][26913] unless execution succeeded
2017-11-27 22:23:47,131 [salt.state       ][INFO    ][26913] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 22:23:47.131153 duration_in_ms=55.234
2017-11-27 22:23:47,132 [salt.state       ][INFO    ][26913] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 22:23:47.131706
2017-11-27 22:23:47,132 [salt.state       ][INFO    ][26913] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'True'
2017-11-27 22:23:47,132 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-27 22:23:47,187 [salt.state       ][INFO    ][26913] unless execution succeeded
2017-11-27 22:23:47,187 [salt.state       ][INFO    ][26913] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 22:23:47.186948 duration_in_ms=55.24
2017-11-27 22:23:47,188 [salt.state       ][INFO    ][26913] Running state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 22:23:47.187523
2017-11-27 22:23:47,188 [salt.state       ][INFO    ][26913] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'
2017-11-27 22:23:47,188 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-11-27 22:23:47,242 [salt.state       ][INFO    ][26913] unless execution succeeded
2017-11-27 22:23:47,243 [salt.state       ][INFO    ][26913] Completed state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 22:23:47.242682 duration_in_ms=55.159
2017-11-27 22:23:47,243 [salt.state       ][INFO    ][26913] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 22:23:47.243353
2017-11-27 22:23:47,244 [salt.state       ][INFO    ][26913] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'True'
2017-11-27 22:23:47,244 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: True'' in directory '/root'
2017-11-27 22:23:47,299 [salt.state       ][INFO    ][26913] unless execution succeeded
2017-11-27 22:23:47,299 [salt.state       ][INFO    ][26913] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 22:23:47.299151 duration_in_ms=55.798
2017-11-27 22:23:47,300 [salt.state       ][INFO    ][26913] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 22:23:47.299776
2017-11-27 22:23:47,300 [salt.state       ][INFO    ][26913] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-11-27 22:23:47,301 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-27 22:23:47,353 [salt.state       ][INFO    ][26913] unless execution succeeded
2017-11-27 22:23:47,353 [salt.state       ][INFO    ][26913] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 22:23:47.353227 duration_in_ms=53.451
2017-11-27 22:23:47,355 [salt.state       ][INFO    ][26913] Running state [nova_instances] at time 22:23:47.354761
2017-11-27 22:23:47,355 [salt.state       ][INFO    ][26913] Executing state glusterfs.started for nova_instances
2017-11-27 22:23:47,355 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:47,363 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:47,417 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:47,424 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:47,484 [salt.state       ][INFO    ][26913] Volume nova_instances is already started
2017-11-27 22:23:47,484 [salt.state       ][INFO    ][26913] Completed state [nova_instances] at time 22:23:47.484038 duration_in_ms=129.276
2017-11-27 22:23:47,485 [salt.state       ][INFO    ][26913] Running state [keystone-credential-keys] at time 22:23:47.485282
2017-11-27 22:23:47,486 [salt.state       ][INFO    ][26913] Executing state glusterfs.created for keystone-credential-keys
2017-11-27 22:23:47,486 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:47,494 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:47,548 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:47,555 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:47,615 [salt.state       ][INFO    ][26913] Volume keystone-credential-keys already exists and is started.
2017-11-27 22:23:47,615 [salt.state       ][INFO    ][26913] Completed state [keystone-credential-keys] at time 22:23:47.614794 duration_in_ms=129.499
2017-11-27 22:23:47,620 [salt.state       ][INFO    ][26913] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 22:23:47.619522
2017-11-27 22:23:47,620 [salt.state       ][INFO    ][26913] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-11-27 22:23:47,620 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-27 22:23:47,675 [salt.state       ][INFO    ][26913] unless execution succeeded
2017-11-27 22:23:47,675 [salt.state       ][INFO    ][26913] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 22:23:47.674962 duration_in_ms=55.44
2017-11-27 22:23:47,676 [salt.state       ][INFO    ][26913] Running state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 22:23:47.675650
2017-11-27 22:23:47,676 [salt.state       ][INFO    ][26913] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'
2017-11-27 22:23:47,677 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-11-27 22:23:47,731 [salt.state       ][INFO    ][26913] unless execution succeeded
2017-11-27 22:23:47,731 [salt.state       ][INFO    ][26913] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 22:23:47.731094 duration_in_ms=55.445
2017-11-27 22:23:47,732 [salt.state       ][INFO    ][26913] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:23:47.731616
2017-11-27 22:23:47,732 [salt.state       ][INFO    ][26913] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-27 22:23:47,732 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-27 22:23:47,785 [salt.state       ][INFO    ][26913] unless execution succeeded
2017-11-27 22:23:47,786 [salt.state       ][INFO    ][26913] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:23:47.785477 duration_in_ms=53.86
2017-11-27 22:23:47,786 [salt.state       ][INFO    ][26913] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 22:23:47.786129
2017-11-27 22:23:47,787 [salt.state       ][INFO    ][26913] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-11-27 22:23:47,787 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-27 22:23:47,841 [salt.state       ][INFO    ][26913] unless execution succeeded
2017-11-27 22:23:47,842 [salt.state       ][INFO    ][26913] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 22:23:47.841464 duration_in_ms=55.335
2017-11-27 22:23:47,842 [salt.state       ][INFO    ][26913] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:23:47.842068
2017-11-27 22:23:47,842 [salt.state       ][INFO    ][26913] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-27 22:23:47,843 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-27 22:23:47,899 [salt.state       ][INFO    ][26913] unless execution succeeded
2017-11-27 22:23:47,899 [salt.state       ][INFO    ][26913] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:23:47.899296 duration_in_ms=57.227
2017-11-27 22:23:47,900 [salt.state       ][INFO    ][26913] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 22:23:47.899879
2017-11-27 22:23:47,900 [salt.state       ][INFO    ][26913] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-11-27 22:23:47,901 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-27 22:23:47,955 [salt.state       ][INFO    ][26913] unless execution succeeded
2017-11-27 22:23:47,955 [salt.state       ][INFO    ][26913] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 22:23:47.954883 duration_in_ms=55.004
2017-11-27 22:23:47,956 [salt.state       ][INFO    ][26913] Running state [keystone-credential-keys] at time 22:23:47.956315
2017-11-27 22:23:47,957 [salt.state       ][INFO    ][26913] Executing state glusterfs.started for keystone-credential-keys
2017-11-27 22:23:47,957 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:47,964 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:48,018 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:48,026 [salt.loaded.int.module.cmdmod][INFO    ][26913] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:48,085 [salt.state       ][INFO    ][26913] Volume keystone-credential-keys is already started
2017-11-27 22:23:48,085 [salt.state       ][INFO    ][26913] Completed state [keystone-credential-keys] at time 22:23:48.084861 duration_in_ms=128.546
2017-11-27 22:23:48,088 [salt.minion      ][INFO    ][26913] Returning information for job: 20171127222341891310
2017-11-27 22:23:57,153 [salt.minion      ][INFO    ][21278] User sudo_ubuntu Executing command test.ping with jid 20171127222357144435
2017-11-27 22:23:57,163 [salt.minion      ][INFO    ][27473] Starting a new job with PID 27473
2017-11-27 22:23:57,198 [salt.minion      ][INFO    ][27473] Returning information for job: 20171127222357144435
2017-11-27 22:23:57,715 [salt.minion      ][INFO    ][21278] User sudo_ubuntu Executing command cmd.run with jid 20171127222357701951
2017-11-27 22:23:57,723 [salt.minion      ][INFO    ][27478] Starting a new job with PID 27478
2017-11-27 22:23:57,727 [salt.loaded.int.module.cmdmod][INFO    ][27478] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-11-27 22:23:57,852 [salt.minion      ][INFO    ][27478] Returning information for job: 20171127222357701951
2017-11-27 23:00:12,901 [salt.utils.schedule][INFO    ][21278] Running scheduled job: __mine_interval
2017-11-27 23:14:22,819 [salt.minion      ][INFO    ][21278] User sudo_ubuntu Executing command test.ping with jid 20171127231422809309
2017-11-27 23:14:22,834 [salt.minion      ][INFO    ][28175] Starting a new job with PID 28175
2017-11-27 23:14:22,873 [salt.minion      ][INFO    ][28175] Returning information for job: 20171127231422809309
2017-11-27 23:15:00,854 [salt.minion      ][INFO    ][21278] User sudo_ubuntu Executing command state.sls with jid 20171127231500840682
2017-11-27 23:15:00,865 [salt.minion      ][INFO    ][28185] Starting a new job with PID 28185
2017-11-27 23:15:01,436 [salt.state       ][INFO    ][28185] Loading fresh modules for state activity
2017-11-27 23:15:01,466 [salt.fileclient  ][INFO    ][28185] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-11-27 23:15:01,484 [salt.fileclient  ][INFO    ][28185] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-11-27 23:15:01,507 [salt.fileclient  ][INFO    ][28185] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-27 23:15:01,807 [salt.state       ][INFO    ][28185] Running state [lsof] at time 23:15:01.807447
2017-11-27 23:15:01,808 [salt.state       ][INFO    ][28185] Executing state pkg.installed for lsof
2017-11-27 23:15:01,808 [salt.loaded.int.module.cmdmod][INFO    ][28185] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-27 23:15:02,134 [salt.state       ][INFO    ][28185] Package lsof is already installed
2017-11-27 23:15:02,134 [salt.state       ][INFO    ][28185] Completed state [lsof] at time 23:15:02.133989 duration_in_ms=326.542
2017-11-27 23:15:02,134 [salt.state       ][INFO    ][28185] Running state [keepalived] at time 23:15:02.134307
2017-11-27 23:15:02,135 [salt.state       ][INFO    ][28185] Executing state pkg.installed for keepalived
2017-11-27 23:15:02,139 [salt.state       ][INFO    ][28185] Package keepalived is already installed
2017-11-27 23:15:02,139 [salt.state       ][INFO    ][28185] Completed state [keepalived] at time 23:15:02.138862 duration_in_ms=4.555
2017-11-27 23:15:02,141 [salt.state       ][INFO    ][28185] Running state [/etc/keepalived/keepalived.conf] at time 23:15:02.140552
2017-11-27 23:15:02,141 [salt.state       ][INFO    ][28185] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-11-27 23:15:02,167 [salt.fileclient  ][INFO    ][28185] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-11-27 23:15:02,209 [salt.fileclient  ][INFO    ][28185] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-27 23:15:02,216 [salt.state       ][INFO    ][28185] File /etc/keepalived/keepalived.conf is in the correct state
2017-11-27 23:15:02,216 [salt.state       ][INFO    ][28185] Completed state [/etc/keepalived/keepalived.conf] at time 23:15:02.215770 duration_in_ms=75.218
2017-11-27 23:15:02,216 [salt.state       ][INFO    ][28185] Running state [keepalived] at time 23:15:02.216442
2017-11-27 23:15:02,217 [salt.state       ][INFO    ][28185] Executing state service.running for keepalived
2017-11-27 23:15:02,217 [salt.loaded.int.module.cmdmod][INFO    ][28185] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-11-27 23:15:02,230 [salt.loaded.int.module.cmdmod][INFO    ][28185] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-27 23:15:02,237 [salt.loaded.int.module.cmdmod][INFO    ][28185] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-27 23:15:02,243 [salt.state       ][INFO    ][28185] The service keepalived is already running
2017-11-27 23:15:02,244 [salt.state       ][INFO    ][28185] Completed state [keepalived] at time 23:15:02.243630 duration_in_ms=27.188
2017-11-27 23:15:02,245 [salt.minion      ][INFO    ][28185] Returning information for job: 20171127231500840682
2017-11-27 23:15:05,142 [salt.minion      ][INFO    ][21278] User sudo_ubuntu Executing command pillar.get with jid 20171127231505133895
2017-11-27 23:15:05,154 [salt.minion      ][INFO    ][28209] Starting a new job with PID 28209
2017-11-27 23:15:05,159 [salt.minion      ][INFO    ][28209] Returning information for job: 20171127231505133895
2017-11-27 23:16:12,455 [salt.minion      ][INFO    ][21278] User sudo_ubuntu Executing command state.sls with jid 20171127231612445670
2017-11-27 23:16:12,465 [salt.minion      ][INFO    ][28227] Starting a new job with PID 28227
2017-11-27 23:16:14,674 [salt.state       ][INFO    ][28227] Loading fresh modules for state activity
2017-11-27 23:16:14,700 [salt.fileclient  ][INFO    ][28227] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-27 23:16:14,722 [salt.fileclient  ][INFO    ][28227] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-27 23:16:15,030 [salt.state       ][INFO    ][28227] Running state [attr] at time 23:16:15.029488
2017-11-27 23:16:15,030 [salt.state       ][INFO    ][28227] Executing state pkg.installed for attr
2017-11-27 23:16:15,030 [salt.loaded.int.module.cmdmod][INFO    ][28227] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-27 23:16:15,330 [salt.state       ][INFO    ][28227] Package attr is already installed
2017-11-27 23:16:15,330 [salt.state       ][INFO    ][28227] Completed state [attr] at time 23:16:15.330321 duration_in_ms=300.834
2017-11-27 23:16:15,331 [salt.state       ][INFO    ][28227] Running state [glusterfs-server] at time 23:16:15.330572
2017-11-27 23:16:15,331 [salt.state       ][INFO    ][28227] Executing state pkg.installed for glusterfs-server
2017-11-27 23:16:15,335 [salt.state       ][INFO    ][28227] Package glusterfs-server is already installed
2017-11-27 23:16:15,335 [salt.state       ][INFO    ][28227] Completed state [glusterfs-server] at time 23:16:15.334774 duration_in_ms=4.202
2017-11-27 23:16:15,335 [salt.state       ][INFO    ][28227] Running state [bc] at time 23:16:15.334963
2017-11-27 23:16:15,335 [salt.state       ][INFO    ][28227] Executing state pkg.installed for bc
2017-11-27 23:16:15,339 [salt.state       ][INFO    ][28227] Package bc is already installed
2017-11-27 23:16:15,339 [salt.state       ][INFO    ][28227] Completed state [bc] at time 23:16:15.338949 duration_in_ms=3.985
2017-11-27 23:16:15,340 [salt.state       ][INFO    ][28227] Running state [glusterfs-server] at time 23:16:15.339763
2017-11-27 23:16:15,340 [salt.state       ][INFO    ][28227] Executing state service.running for glusterfs-server
2017-11-27 23:16:15,340 [salt.loaded.int.module.cmdmod][INFO    ][28227] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-27 23:16:15,357 [salt.loaded.int.module.cmdmod][INFO    ][28227] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-27 23:16:15,363 [salt.loaded.int.module.cmdmod][INFO    ][28227] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-27 23:16:15,372 [salt.state       ][INFO    ][28227] The service glusterfs-server is already running
2017-11-27 23:16:15,372 [salt.state       ][INFO    ][28227] Completed state [glusterfs-server] at time 23:16:15.372328 duration_in_ms=32.565
2017-11-27 23:16:15,374 [salt.state       ][INFO    ][28227] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 23:16:15.373851
2017-11-27 23:16:15,374 [salt.state       ][INFO    ][28227] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-27 23:16:15,376 [salt.state       ][INFO    ][28227] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-27 23:16:15,376 [salt.state       ][INFO    ][28227] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 23:16:15.376300 duration_in_ms=2.449
2017-11-27 23:16:15,377 [salt.state       ][INFO    ][28227] Running state [/srv/glusterfs/glance] at time 23:16:15.376488
2017-11-27 23:16:15,377 [salt.state       ][INFO    ][28227] Executing state file.directory for /srv/glusterfs/glance
2017-11-27 23:16:15,377 [salt.state       ][INFO    ][28227] Directory /srv/glusterfs/glance is in the correct state
2017-11-27 23:16:15,377 [salt.state       ][INFO    ][28227] Completed state [/srv/glusterfs/glance] at time 23:16:15.377228 duration_in_ms=0.74
2017-11-27 23:16:15,377 [salt.state       ][INFO    ][28227] Running state [/srv/glusterfs/keystone-keys] at time 23:16:15.377413
2017-11-27 23:16:15,378 [salt.state       ][INFO    ][28227] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-27 23:16:15,378 [salt.state       ][INFO    ][28227] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-27 23:16:15,378 [salt.state       ][INFO    ][28227] Completed state [/srv/glusterfs/keystone-keys] at time 23:16:15.378160 duration_in_ms=0.747
2017-11-27 23:16:15,378 [salt.state       ][INFO    ][28227] Running state [/srv/glusterfs/nova_instances] at time 23:16:15.378339
2017-11-27 23:16:15,379 [salt.state       ][INFO    ][28227] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-27 23:16:15,379 [salt.state       ][INFO    ][28227] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-27 23:16:15,379 [salt.state       ][INFO    ][28227] Completed state [/srv/glusterfs/nova_instances] at time 23:16:15.379087 duration_in_ms=0.749
2017-11-27 23:16:15,379 [salt.state       ][INFO    ][28227] Running state [/srv/glusterfs/keystone-credential-keys] at time 23:16:15.379263
2017-11-27 23:16:15,379 [salt.state       ][INFO    ][28227] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-27 23:16:15,380 [salt.state       ][INFO    ][28227] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-27 23:16:15,380 [salt.state       ][INFO    ][28227] Completed state [/srv/glusterfs/keystone-credential-keys] at time 23:16:15.379989 duration_in_ms=0.726
2017-11-27 23:16:15,381 [salt.minion      ][INFO    ][28227] Returning information for job: 20171127231612445670
2017-11-27 23:16:17,300 [salt.minion      ][INFO    ][21278] User sudo_ubuntu Executing command test.ping with jid 20171127231617292006
2017-11-27 23:16:17,311 [salt.minion      ][INFO    ][28250] Starting a new job with PID 28250
2017-11-27 23:16:17,346 [salt.minion      ][INFO    ][28250] Returning information for job: 20171127231617292006
2017-11-27 23:16:25,182 [salt.minion      ][INFO    ][21278] User sudo_ubuntu Executing command state.sls with jid 20171127231625170483
2017-11-27 23:16:25,192 [salt.minion      ][INFO    ][28255] Starting a new job with PID 28255
2017-11-27 23:16:25,785 [salt.state       ][INFO    ][28255] Loading fresh modules for state activity
2017-11-27 23:16:25,811 [salt.fileclient  ][INFO    ][28255] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-11-27 23:16:25,852 [salt.fileclient  ][INFO    ][28255] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-27 23:16:25,940 [salt.fileclient  ][INFO    ][28255] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-27 23:16:25,963 [salt.fileclient  ][INFO    ][28255] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-27 23:16:26,274 [salt.state       ][INFO    ][28255] Running state [attr] at time 23:16:26.273613
2017-11-27 23:16:26,274 [salt.state       ][INFO    ][28255] Executing state pkg.installed for attr
2017-11-27 23:16:26,274 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-27 23:16:26,531 [salt.state       ][INFO    ][28255] Package attr is already installed
2017-11-27 23:16:26,532 [salt.state       ][INFO    ][28255] Completed state [attr] at time 23:16:26.531524 duration_in_ms=257.91
2017-11-27 23:16:26,532 [salt.state       ][INFO    ][28255] Running state [glusterfs-server] at time 23:16:26.531788
2017-11-27 23:16:26,532 [salt.state       ][INFO    ][28255] Executing state pkg.installed for glusterfs-server
2017-11-27 23:16:26,536 [salt.state       ][INFO    ][28255] Package glusterfs-server is already installed
2017-11-27 23:16:26,537 [salt.state       ][INFO    ][28255] Completed state [glusterfs-server] at time 23:16:26.536486 duration_in_ms=4.698
2017-11-27 23:16:26,537 [salt.state       ][INFO    ][28255] Running state [bc] at time 23:16:26.536680
2017-11-27 23:16:26,537 [salt.state       ][INFO    ][28255] Executing state pkg.installed for bc
2017-11-27 23:16:26,540 [salt.state       ][INFO    ][28255] Package bc is already installed
2017-11-27 23:16:26,541 [salt.state       ][INFO    ][28255] Completed state [bc] at time 23:16:26.540566 duration_in_ms=3.885
2017-11-27 23:16:26,542 [salt.state       ][INFO    ][28255] Running state [glusterfs-server] at time 23:16:26.541596
2017-11-27 23:16:26,542 [salt.state       ][INFO    ][28255] Executing state service.running for glusterfs-server
2017-11-27 23:16:26,542 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-27 23:16:26,558 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-27 23:16:26,567 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-27 23:16:26,577 [salt.state       ][INFO    ][28255] The service glusterfs-server is already running
2017-11-27 23:16:26,577 [salt.state       ][INFO    ][28255] Completed state [glusterfs-server] at time 23:16:26.576829 duration_in_ms=35.233
2017-11-27 23:16:26,579 [salt.state       ][INFO    ][28255] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 23:16:26.578513
2017-11-27 23:16:26,579 [salt.state       ][INFO    ][28255] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-27 23:16:26,581 [salt.state       ][INFO    ][28255] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-27 23:16:26,581 [salt.state       ][INFO    ][28255] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 23:16:26.580805 duration_in_ms=2.292
2017-11-27 23:16:26,581 [salt.state       ][INFO    ][28255] Running state [/srv/glusterfs/glance] at time 23:16:26.580999
2017-11-27 23:16:26,581 [salt.state       ][INFO    ][28255] Executing state file.directory for /srv/glusterfs/glance
2017-11-27 23:16:26,582 [salt.state       ][INFO    ][28255] Directory /srv/glusterfs/glance is in the correct state
2017-11-27 23:16:26,582 [salt.state       ][INFO    ][28255] Completed state [/srv/glusterfs/glance] at time 23:16:26.581778 duration_in_ms=0.78
2017-11-27 23:16:26,582 [salt.state       ][INFO    ][28255] Running state [/srv/glusterfs/keystone-keys] at time 23:16:26.581990
2017-11-27 23:16:26,582 [salt.state       ][INFO    ][28255] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-27 23:16:26,583 [salt.state       ][INFO    ][28255] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-27 23:16:26,583 [salt.state       ][INFO    ][28255] Completed state [/srv/glusterfs/keystone-keys] at time 23:16:26.582800 duration_in_ms=0.81
2017-11-27 23:16:26,583 [salt.state       ][INFO    ][28255] Running state [/srv/glusterfs/nova_instances] at time 23:16:26.582990
2017-11-27 23:16:26,583 [salt.state       ][INFO    ][28255] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-27 23:16:26,584 [salt.state       ][INFO    ][28255] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-27 23:16:26,584 [salt.state       ][INFO    ][28255] Completed state [/srv/glusterfs/nova_instances] at time 23:16:26.583703 duration_in_ms=0.713
2017-11-27 23:16:26,584 [salt.state       ][INFO    ][28255] Running state [/srv/glusterfs/keystone-credential-keys] at time 23:16:26.583876
2017-11-27 23:16:26,584 [salt.state       ][INFO    ][28255] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-27 23:16:26,584 [salt.state       ][INFO    ][28255] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-27 23:16:26,585 [salt.state       ][INFO    ][28255] Completed state [/srv/glusterfs/keystone-credential-keys] at time 23:16:26.584564 duration_in_ms=0.689
2017-11-27 23:16:26,681 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command ['git', '--version'] in directory '/root'
2017-11-27 23:16:26,727 [salt.state       ][INFO    ][28255] Running state [sleep 5] at time 23:16:26.726492
2017-11-27 23:16:26,727 [salt.state       ][INFO    ][28255] Executing state cmd.wait for sleep 5
2017-11-27 23:16:26,727 [salt.state       ][INFO    ][28255] No changes made for sleep 5
2017-11-27 23:16:26,727 [salt.state       ][INFO    ][28255] Completed state [sleep 5] at time 23:16:26.727110 duration_in_ms=0.619
2017-11-27 23:16:26,728 [salt.state       ][INFO    ][28255] Running state [192.168.10.143] at time 23:16:26.727648
2017-11-27 23:16:26,728 [salt.state       ][INFO    ][28255] Executing state glusterfs.peered for 192.168.10.143
2017-11-27 23:16:26,728 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:26,737 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:26,795 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:26,803 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:26,860 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:26,866 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:26,924 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:26,933 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:26,987 [salt.state       ][INFO    ][28255] Peering with localhost is not needed
2017-11-27 23:16:26,987 [salt.state       ][INFO    ][28255] Completed state [192.168.10.143] at time 23:16:26.986762 duration_in_ms=259.112
2017-11-27 23:16:26,990 [salt.state       ][INFO    ][28255] Running state [192.168.10.142] at time 23:16:26.989741
2017-11-27 23:16:26,990 [salt.state       ][INFO    ][28255] Executing state glusterfs.peered for 192.168.10.142
2017-11-27 23:16:26,991 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:26,999 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:27,056 [salt.state       ][INFO    ][28255] Host 192.168.10.142 already peered
2017-11-27 23:16:27,056 [salt.state       ][INFO    ][28255] Completed state [192.168.10.142] at time 23:16:27.055739 duration_in_ms=65.998
2017-11-27 23:16:27,059 [salt.state       ][INFO    ][28255] Running state [192.168.10.141] at time 23:16:27.058756
2017-11-27 23:16:27,059 [salt.state       ][INFO    ][28255] Executing state glusterfs.peered for 192.168.10.141
2017-11-27 23:16:27,059 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:27,067 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:27,122 [salt.state       ][INFO    ][28255] Host 192.168.10.141 already peered
2017-11-27 23:16:27,123 [salt.state       ][INFO    ][28255] Completed state [192.168.10.141] at time 23:16:27.122554 duration_in_ms=63.797
2017-11-27 23:16:27,124 [salt.state       ][INFO    ][28255] Running state [glance] at time 23:16:27.123658
2017-11-27 23:16:27,124 [salt.state       ][INFO    ][28255] Executing state glusterfs.created for glance
2017-11-27 23:16:27,124 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:27,133 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:27,189 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:27,197 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:27,260 [salt.state       ][INFO    ][28255] Volume glance already exists and is started.
2017-11-27 23:16:27,260 [salt.state       ][INFO    ][28255] Completed state [glance] at time 23:16:27.260317 duration_in_ms=136.658
2017-11-27 23:16:27,265 [salt.state       ][INFO    ][28255] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 23:16:27.264645
2017-11-27 23:16:27,265 [salt.state       ][INFO    ][28255] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-11-27 23:16:27,265 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-27 23:16:27,320 [salt.state       ][INFO    ][28255] unless execution succeeded
2017-11-27 23:16:27,320 [salt.state       ][INFO    ][28255] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 23:16:27.320207 duration_in_ms=55.562
2017-11-27 23:16:27,321 [salt.state       ][INFO    ][28255] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 23:16:27.320800
2017-11-27 23:16:27,321 [salt.state       ][INFO    ][28255] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-11-27 23:16:27,322 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-27 23:16:27,377 [salt.state       ][INFO    ][28255] unless execution succeeded
2017-11-27 23:16:27,377 [salt.state       ][INFO    ][28255] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 23:16:27.376886 duration_in_ms=56.085
2017-11-27 23:16:27,377 [salt.state       ][INFO    ][28255] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 23:16:27.377413
2017-11-27 23:16:27,378 [salt.state       ][INFO    ][28255] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-11-27 23:16:27,378 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-11-27 23:16:27,433 [salt.state       ][INFO    ][28255] unless execution succeeded
2017-11-27 23:16:27,434 [salt.state       ][INFO    ][28255] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 23:16:27.433612 duration_in_ms=56.199
2017-11-27 23:16:27,434 [salt.state       ][INFO    ][28255] Running state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 23:16:27.434320
2017-11-27 23:16:27,435 [salt.state       ][INFO    ][28255] Executing state cmd.run for gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'
2017-11-27 23:16:27,435 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster volume info 'glance' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-11-27 23:16:27,489 [salt.state       ][INFO    ][28255] unless execution succeeded
2017-11-27 23:16:27,489 [salt.state       ][INFO    ][28255] Completed state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 23:16:27.488900 duration_in_ms=54.579
2017-11-27 23:16:27,489 [salt.state       ][INFO    ][28255] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 23:16:27.489463
2017-11-27 23:16:27,490 [salt.state       ][INFO    ][28255] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-11-27 23:16:27,490 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-27 23:16:27,544 [salt.state       ][INFO    ][28255] unless execution succeeded
2017-11-27 23:16:27,544 [salt.state       ][INFO    ][28255] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 23:16:27.544442 duration_in_ms=54.977
2017-11-27 23:16:27,545 [salt.state       ][INFO    ][28255] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 23:16:27.545073
2017-11-27 23:16:27,545 [salt.state       ][INFO    ][28255] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-11-27 23:16:27,546 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-27 23:16:27,605 [salt.state       ][INFO    ][28255] unless execution succeeded
2017-11-27 23:16:27,606 [salt.state       ][INFO    ][28255] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 23:16:27.605474 duration_in_ms=60.4
2017-11-27 23:16:27,607 [salt.state       ][INFO    ][28255] Running state [glance] at time 23:16:27.607098
2017-11-27 23:16:27,607 [salt.state       ][INFO    ][28255] Executing state glusterfs.started for glance
2017-11-27 23:16:27,608 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:27,616 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:27,672 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:27,679 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:27,741 [salt.state       ][INFO    ][28255] Volume glance is already started
2017-11-27 23:16:27,741 [salt.state       ][INFO    ][28255] Completed state [glance] at time 23:16:27.741434 duration_in_ms=134.336
2017-11-27 23:16:27,743 [salt.state       ][INFO    ][28255] Running state [keystone-keys] at time 23:16:27.742660
2017-11-27 23:16:27,743 [salt.state       ][INFO    ][28255] Executing state glusterfs.created for keystone-keys
2017-11-27 23:16:27,743 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:27,752 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:27,806 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:27,814 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:27,879 [salt.state       ][INFO    ][28255] Volume keystone-keys already exists and is started.
2017-11-27 23:16:27,879 [salt.state       ][INFO    ][28255] Completed state [keystone-keys] at time 23:16:27.879087 duration_in_ms=136.427
2017-11-27 23:16:27,884 [salt.state       ][INFO    ][28255] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 23:16:27.883821
2017-11-27 23:16:27,884 [salt.state       ][INFO    ][28255] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-11-27 23:16:27,885 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-27 23:16:27,941 [salt.state       ][INFO    ][28255] unless execution succeeded
2017-11-27 23:16:27,941 [salt.state       ][INFO    ][28255] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 23:16:27.941154 duration_in_ms=57.332
2017-11-27 23:16:27,942 [salt.state       ][INFO    ][28255] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 23:16:27.941949
2017-11-27 23:16:27,942 [salt.state       ][INFO    ][28255] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-27 23:16:27,943 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-27 23:16:27,999 [salt.state       ][INFO    ][28255] unless execution succeeded
2017-11-27 23:16:27,999 [salt.state       ][INFO    ][28255] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 23:16:27.999210 duration_in_ms=57.26
2017-11-27 23:16:27,1000 [salt.state       ][INFO    ][28255] Running state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 23:16:27.999800
2017-11-27 23:16:28,000 [salt.state       ][INFO    ][28255] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'
2017-11-27 23:16:28,001 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-11-27 23:16:28,057 [salt.state       ][INFO    ][28255] unless execution succeeded
2017-11-27 23:16:28,057 [salt.state       ][INFO    ][28255] Completed state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 23:16:28.057159 duration_in_ms=57.359
2017-11-27 23:16:28,058 [salt.state       ][INFO    ][28255] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 23:16:28.057846
2017-11-27 23:16:28,058 [salt.state       ][INFO    ][28255] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-27 23:16:28,059 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-27 23:16:28,116 [salt.state       ][INFO    ][28255] unless execution succeeded
2017-11-27 23:16:28,116 [salt.state       ][INFO    ][28255] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 23:16:28.116398 duration_in_ms=58.551
2017-11-27 23:16:28,117 [salt.state       ][INFO    ][28255] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 23:16:28.117129
2017-11-27 23:16:28,118 [salt.state       ][INFO    ][28255] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-11-27 23:16:28,118 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-27 23:16:28,175 [salt.state       ][INFO    ][28255] unless execution succeeded
2017-11-27 23:16:28,175 [salt.state       ][INFO    ][28255] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 23:16:28.175126 duration_in_ms=57.997
2017-11-27 23:16:28,176 [salt.state       ][INFO    ][28255] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 23:16:28.175773
2017-11-27 23:16:28,176 [salt.state       ][INFO    ][28255] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-11-27 23:16:28,177 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-27 23:16:28,232 [salt.state       ][INFO    ][28255] unless execution succeeded
2017-11-27 23:16:28,232 [salt.state       ][INFO    ][28255] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 23:16:28.232050 duration_in_ms=56.277
2017-11-27 23:16:28,234 [salt.state       ][INFO    ][28255] Running state [keystone-keys] at time 23:16:28.233671
2017-11-27 23:16:28,234 [salt.state       ][INFO    ][28255] Executing state glusterfs.started for keystone-keys
2017-11-27 23:16:28,235 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:28,242 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:28,299 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:28,306 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:28,366 [salt.state       ][INFO    ][28255] Volume keystone-keys is already started
2017-11-27 23:16:28,366 [salt.state       ][INFO    ][28255] Completed state [keystone-keys] at time 23:16:28.366021 duration_in_ms=132.349
2017-11-27 23:16:28,367 [salt.state       ][INFO    ][28255] Running state [nova_instances] at time 23:16:28.367296
2017-11-27 23:16:28,368 [salt.state       ][INFO    ][28255] Executing state glusterfs.created for nova_instances
2017-11-27 23:16:28,368 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:28,375 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:28,430 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:28,438 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:28,499 [salt.state       ][INFO    ][28255] Volume nova_instances already exists and is started.
2017-11-27 23:16:28,499 [salt.state       ][INFO    ][28255] Completed state [nova_instances] at time 23:16:28.499107 duration_in_ms=131.811
2017-11-27 23:16:28,504 [salt.state       ][INFO    ][28255] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 23:16:28.503734
2017-11-27 23:16:28,504 [salt.state       ][INFO    ][28255] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-11-27 23:16:28,504 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-27 23:16:28,560 [salt.state       ][INFO    ][28255] unless execution succeeded
2017-11-27 23:16:28,560 [salt.state       ][INFO    ][28255] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 23:16:28.560140 duration_in_ms=56.404
2017-11-27 23:16:28,561 [salt.state       ][INFO    ][28255] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 23:16:28.560916
2017-11-27 23:16:28,561 [salt.state       ][INFO    ][28255] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'
2017-11-27 23:16:28,562 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-27 23:16:28,618 [salt.state       ][INFO    ][28255] unless execution succeeded
2017-11-27 23:16:28,618 [salt.state       ][INFO    ][28255] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 23:16:28.617803 duration_in_ms=56.887
2017-11-27 23:16:28,619 [salt.state       ][INFO    ][28255] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 23:16:28.618475
2017-11-27 23:16:28,619 [salt.state       ][INFO    ][28255] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'True'
2017-11-27 23:16:28,619 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-27 23:16:28,677 [salt.state       ][INFO    ][28255] unless execution succeeded
2017-11-27 23:16:28,677 [salt.state       ][INFO    ][28255] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 23:16:28.677092 duration_in_ms=58.617
2017-11-27 23:16:28,678 [salt.state       ][INFO    ][28255] Running state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 23:16:28.677713
2017-11-27 23:16:28,678 [salt.state       ][INFO    ][28255] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'
2017-11-27 23:16:28,679 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-11-27 23:16:28,733 [salt.state       ][INFO    ][28255] unless execution succeeded
2017-11-27 23:16:28,734 [salt.state       ][INFO    ][28255] Completed state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 23:16:28.733732 duration_in_ms=56.018
2017-11-27 23:16:28,734 [salt.state       ][INFO    ][28255] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 23:16:28.734371
2017-11-27 23:16:28,735 [salt.state       ][INFO    ][28255] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'True'
2017-11-27 23:16:28,735 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: True'' in directory '/root'
2017-11-27 23:16:28,790 [salt.state       ][INFO    ][28255] unless execution succeeded
2017-11-27 23:16:28,791 [salt.state       ][INFO    ][28255] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 23:16:28.790517 duration_in_ms=56.145
2017-11-27 23:16:28,791 [salt.state       ][INFO    ][28255] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 23:16:28.791079
2017-11-27 23:16:28,791 [salt.state       ][INFO    ][28255] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-11-27 23:16:28,792 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-27 23:16:28,845 [salt.state       ][INFO    ][28255] unless execution succeeded
2017-11-27 23:16:28,845 [salt.state       ][INFO    ][28255] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 23:16:28.845294 duration_in_ms=54.202
2017-11-27 23:16:28,847 [salt.state       ][INFO    ][28255] Running state [nova_instances] at time 23:16:28.846828
2017-11-27 23:16:28,847 [salt.state       ][INFO    ][28255] Executing state glusterfs.started for nova_instances
2017-11-27 23:16:28,847 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:28,855 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:28,911 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:28,918 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:28,982 [salt.state       ][INFO    ][28255] Volume nova_instances is already started
2017-11-27 23:16:28,983 [salt.state       ][INFO    ][28255] Completed state [nova_instances] at time 23:16:28.982485 duration_in_ms=135.657
2017-11-27 23:16:28,984 [salt.state       ][INFO    ][28255] Running state [keystone-credential-keys] at time 23:16:28.983824
2017-11-27 23:16:28,984 [salt.state       ][INFO    ][28255] Executing state glusterfs.created for keystone-credential-keys
2017-11-27 23:16:28,985 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:28,993 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:29,049 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:29,057 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:29,120 [salt.state       ][INFO    ][28255] Volume keystone-credential-keys already exists and is started.
2017-11-27 23:16:29,120 [salt.state       ][INFO    ][28255] Completed state [keystone-credential-keys] at time 23:16:29.119778 duration_in_ms=135.952
2017-11-27 23:16:29,125 [salt.state       ][INFO    ][28255] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 23:16:29.124819
2017-11-27 23:16:29,125 [salt.state       ][INFO    ][28255] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-11-27 23:16:29,126 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-27 23:16:29,182 [salt.state       ][INFO    ][28255] unless execution succeeded
2017-11-27 23:16:29,182 [salt.state       ][INFO    ][28255] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 23:16:29.182357 duration_in_ms=57.537
2017-11-27 23:16:29,183 [salt.state       ][INFO    ][28255] Running state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 23:16:29.183086
2017-11-27 23:16:29,183 [salt.state       ][INFO    ][28255] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'
2017-11-27 23:16:29,184 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-11-27 23:16:29,240 [salt.state       ][INFO    ][28255] unless execution succeeded
2017-11-27 23:16:29,240 [salt.state       ][INFO    ][28255] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 23:16:29.240155 duration_in_ms=57.059
2017-11-27 23:16:29,241 [salt.state       ][INFO    ][28255] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 23:16:29.240723
2017-11-27 23:16:29,241 [salt.state       ][INFO    ][28255] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-27 23:16:29,242 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-27 23:16:29,298 [salt.state       ][INFO    ][28255] unless execution succeeded
2017-11-27 23:16:29,299 [salt.state       ][INFO    ][28255] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 23:16:29.298652 duration_in_ms=57.929
2017-11-27 23:16:29,299 [salt.state       ][INFO    ][28255] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 23:16:29.299237
2017-11-27 23:16:29,299 [salt.state       ][INFO    ][28255] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-11-27 23:16:29,300 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-27 23:16:29,356 [salt.state       ][INFO    ][28255] unless execution succeeded
2017-11-27 23:16:29,356 [salt.state       ][INFO    ][28255] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 23:16:29.356156 duration_in_ms=56.918
2017-11-27 23:16:29,357 [salt.state       ][INFO    ][28255] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 23:16:29.356812
2017-11-27 23:16:29,357 [salt.state       ][INFO    ][28255] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-27 23:16:29,358 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-27 23:16:29,416 [salt.state       ][INFO    ][28255] unless execution succeeded
2017-11-27 23:16:29,416 [salt.state       ][INFO    ][28255] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 23:16:29.415781 duration_in_ms=58.968
2017-11-27 23:16:29,416 [salt.state       ][INFO    ][28255] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 23:16:29.416331
2017-11-27 23:16:29,417 [salt.state       ][INFO    ][28255] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-11-27 23:16:29,417 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-27 23:16:29,472 [salt.state       ][INFO    ][28255] unless execution succeeded
2017-11-27 23:16:29,473 [salt.state       ][INFO    ][28255] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 23:16:29.472482 duration_in_ms=56.151
2017-11-27 23:16:29,474 [salt.state       ][INFO    ][28255] Running state [keystone-credential-keys] at time 23:16:29.474014
2017-11-27 23:16:29,474 [salt.state       ][INFO    ][28255] Executing state glusterfs.started for keystone-credential-keys
2017-11-27 23:16:29,475 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:29,482 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:29,537 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:29,543 [salt.loaded.int.module.cmdmod][INFO    ][28255] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:29,605 [salt.state       ][INFO    ][28255] Volume keystone-credential-keys is already started
2017-11-27 23:16:29,606 [salt.state       ][INFO    ][28255] Completed state [keystone-credential-keys] at time 23:16:29.605714 duration_in_ms=131.699
2017-11-27 23:16:29,608 [salt.minion      ][INFO    ][28255] Returning information for job: 20171127231625170483
2017-11-27 23:16:39,576 [salt.minion      ][INFO    ][21278] User sudo_ubuntu Executing command test.ping with jid 20171127231639566828
2017-11-27 23:16:39,586 [salt.minion      ][INFO    ][28765] Starting a new job with PID 28765
2017-11-27 23:16:39,623 [salt.minion      ][INFO    ][28765] Returning information for job: 20171127231639566828
2017-11-27 23:16:40,174 [salt.minion      ][INFO    ][21278] User sudo_ubuntu Executing command cmd.run with jid 20171127231640164204
2017-11-27 23:16:40,182 [salt.minion      ][INFO    ][28770] Starting a new job with PID 28770
2017-11-27 23:16:40,188 [salt.loaded.int.module.cmdmod][INFO    ][28770] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-11-27 23:16:40,320 [salt.minion      ][INFO    ][28770] Returning information for job: 20171127231640164204
2017-11-27 23:39:25,729 [salt.minion      ][INFO    ][21278] User sudo_ubuntu Executing command cp.push_dir with jid 20171127233925713756
2017-11-27 23:39:25,742 [salt.minion      ][INFO    ][28945] Starting a new job with PID 28945
