2017-11-23 07:41:25,211 [salt.cli.daemons ][WARNING ][2109] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-23 07:41:48,507 [salt.state       ][ERROR   ][3650] No contents found in top file
2017-11-23 07:43:40,046 [salt.utils.parsers][WARNING ][2109] Minion received a SIGTERM. Exiting.
2017-11-23 07:48:05,980 [salt.cli.daemons ][WARNING ][3350] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-23 07:50:38,344 [py.warnings      ][WARNING ][16161] /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-23 07:54:52,045 [salt.loaded.int.module.cmdmod][ERROR   ][16161] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-23 07:54:52,046 [salt.loaded.int.module.cmdmod][ERROR   ][16161] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-23 07:54:56,726 [salt.loaded.int.module.cmdmod][ERROR   ][16161] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-23 07:54:56,727 [salt.loaded.int.module.cmdmod][ERROR   ][16161] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-23 07:55:00,937 [salt.loaded.int.module.cmdmod][ERROR   ][16161] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-23 07:55:00,938 [salt.loaded.int.module.cmdmod][ERROR   ][16161] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-23 07:55:05,112 [salt.loaded.int.module.cmdmod][ERROR   ][16161] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-23 07:55:05,113 [salt.loaded.int.module.cmdmod][ERROR   ][16161] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-23 07:55:09,401 [salt.loaded.int.module.cmdmod][ERROR   ][16161] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-23 07:55:09,401 [salt.loaded.int.module.cmdmod][ERROR   ][16161] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-23 07:55:12,986 [salt.loaded.int.module.cmdmod][ERROR   ][16161] 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-23 07:55:15,780 [salt.loaded.int.module.cmdmod][INFO    ][23937] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-23 07:55:15,787 [salt.loaded.int.module.cmdmod][INFO    ][23937] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-23 07:55:15,795 [salt.loaded.int.module.cmdmod][INFO    ][23937] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-11-23 07:55:15,803 [salt.utils.parsers][WARNING ][3350] Minion received a SIGTERM. Exiting.
2017-11-23 07:55:16,125 [salt.cli.daemons ][INFO    ][24012] Setting up the Salt Minion "kvm01.baremetal-mcp-ocata-odl-ha.local"
2017-11-23 07:55:16,773 [salt.minion      ][INFO    ][24012] Creating minion process manager
2017-11-23 07:55:16,773 [salt.cli.daemons ][WARNING ][24012] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-23 07:55:16,773 [salt.cli.daemons ][INFO    ][24012] The Salt Minion is starting up
2017-11-23 07:55:16,774 [salt.minion      ][INFO    ][24012] Minion is starting as user 'root'
2017-11-23 07:55:16,774 [salt.utils.event ][INFO    ][24012] Starting pull socket on /var/run/salt/minion/minion_event_127643860a_pull.ipc
2017-11-23 07:55:17,914 [salt.loaded.int.module.cmdmod][INFO    ][24012] Executing command ['date', '+%z'] in directory '/root'
2017-11-23 07:55:17,925 [salt.utils.schedule][INFO    ][24012] Updating job settings for scheduled job: __mine_interval
2017-11-23 07:55:17,928 [salt.minion      ][INFO    ][24012] Added mine.update to scheduler
2017-11-23 07:55:17,961 [salt.minion      ][INFO    ][24012] Minion is ready to receive requests!
2017-11-23 07:55:18,962 [salt.utils.schedule][INFO    ][24012] Running scheduled job: __mine_interval
2017-11-23 07:55:19,774 [salt.minion      ][INFO    ][24012] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171123075519764988
2017-11-23 07:55:19,784 [salt.minion      ][INFO    ][24112] Starting a new job with PID 24112
2017-11-23 07:55:22,403 [salt.state       ][INFO    ][24112] Loading fresh modules for state activity
2017-11-23 07:55:22,427 [salt.state       ][ERROR   ][24112] No contents found in top file
2017-11-23 07:55:22,428 [salt.utils.extmods][INFO    ][24112] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-11-23 07:55:22,431 [salt.utils.extmods][INFO    ][24112] Syncing beacons for environment 'base'
2017-11-23 07:55:22,431 [salt.utils.extmods][INFO    ][24112] Loading cache from salt://_beacons, for base)
2017-11-23 07:55:22,432 [salt.fileclient  ][INFO    ][24112] Caching directory '_beacons/' for environment 'base'
2017-11-23 07:55:22,475 [salt.utils.extmods][INFO    ][24112] Syncing modules for environment 'base'
2017-11-23 07:55:22,475 [salt.utils.extmods][INFO    ][24112] Loading cache from salt://_modules, for base)
2017-11-23 07:55:22,475 [salt.fileclient  ][INFO    ][24112] Caching directory '_modules/' for environment 'base'
2017-11-23 07:55:22,521 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-11-23 07:55:22,531 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-11-23 07:55:22,543 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-11-23 07:55:22,554 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-11-23 07:55:22,564 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-11-23 07:55:22,578 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-11-23 07:55:22,594 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-11-23 07:55:22,607 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-11-23 07:55:22,623 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-11-23 07:55:22,634 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-11-23 07:55:22,646 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-11-23 07:55:22,657 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-11-23 07:55:22,669 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-11-23 07:55:22,680 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-11-23 07:55:22,693 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-11-23 07:55:22,706 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-11-23 07:55:22,718 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-11-23 07:55:22,730 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-11-23 07:55:22,745 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-11-23 07:55:22,758 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-11-23 07:55:22,770 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-11-23 07:55:22,782 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-11-23 07:55:22,797 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-11-23 07:55:22,814 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-11-23 07:55:22,824 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-11-23 07:55:22,832 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-11-23 07:55:22,842 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-11-23 07:55:22,856 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-11-23 07:55:22,871 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-11-23 07:55:22,879 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-11-23 07:55:22,888 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-11-23 07:55:23,379 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-11-23 07:55:23,394 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-11-23 07:55:23,398 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-11-23 07:55:23,398 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-11-23 07:55:23,399 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-11-23 07:55:23,399 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-11-23 07:55:23,399 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-11-23 07:55:23,400 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-11-23 07:55:23,400 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-11-23 07:55:23,400 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-11-23 07:55:23,400 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-11-23 07:55:23,401 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-11-23 07:55:23,401 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-11-23 07:55:23,401 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-11-23 07:55:23,401 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-11-23 07:55:23,402 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-11-23 07:55:23,402 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-11-23 07:55:23,402 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-11-23 07:55:23,402 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-11-23 07:55:23,402 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-11-23 07:55:23,403 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2017-11-23 07:55:23,403 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-11-23 07:55:23,403 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-11-23 07:55:23,403 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-11-23 07:55:23,404 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-11-23 07:55:23,404 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-11-23 07:55:23,404 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-11-23 07:55:23,405 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-11-23 07:55:23,405 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-11-23 07:55:23,405 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-11-23 07:55:23,405 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-11-23 07:55:23,406 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-11-23 07:55:23,406 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-11-23 07:55:23,406 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-11-23 07:55:23,406 [salt.utils.extmods][INFO    ][24112] 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-23 07:55:23,407 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-11-23 07:55:23,407 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-11-23 07:55:23,412 [salt.utils.extmods][INFO    ][24112] Syncing states for environment 'base'
2017-11-23 07:55:23,412 [salt.utils.extmods][INFO    ][24112] Loading cache from salt://_states, for base)
2017-11-23 07:55:23,413 [salt.fileclient  ][INFO    ][24112] Caching directory '_states/' for environment 'base'
2017-11-23 07:55:23,459 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-11-23 07:55:23,470 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-11-23 07:55:23,481 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-11-23 07:55:23,499 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-11-23 07:55:23,510 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-11-23 07:55:23,522 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-11-23 07:55:23,535 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-11-23 07:55:23,547 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-11-23 07:55:23,559 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-11-23 07:55:23,570 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-11-23 07:55:23,581 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-11-23 07:55:23,593 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_states/jenkins_globalenvprop.py'
2017-11-23 07:55:23,606 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-11-23 07:55:23,619 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-11-23 07:55:23,627 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-11-23 07:55:23,636 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-11-23 07:55:23,650 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-11-23 07:55:23,660 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-11-23 07:55:23,670 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-11-23 07:55:23,681 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-11-23 07:55:23,692 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-11-23 07:55:23,703 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-11-23 07:55:23,716 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-11-23 07:55:23,726 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-11-23 07:55:23,746 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-11-23 07:55:23,757 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-11-23 07:55:23,771 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-11-23 07:55:23,782 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-11-23 07:55:23,796 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-11-23 07:55:23,804 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-11-23 07:55:23,808 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-11-23 07:55:23,808 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-11-23 07:55:23,809 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-11-23 07:55:23,809 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-11-23 07:55:23,809 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-11-23 07:55:23,810 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-11-23 07:55:23,810 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-11-23 07:55:23,810 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-11-23 07:55:23,811 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-11-23 07:55:23,811 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-11-23 07:55:23,811 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-11-23 07:55:23,811 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_states/jenkins_globalenvprop.py' to '/var/cache/salt/minion/extmods/states/jenkins_globalenvprop.py'
2017-11-23 07:55:23,812 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-11-23 07:55:23,812 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-11-23 07:55:23,812 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-11-23 07:55:23,812 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-11-23 07:55:23,812 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-11-23 07:55:23,813 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-11-23 07:55:23,813 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-11-23 07:55:23,813 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-11-23 07:55:23,814 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-11-23 07:55:23,814 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-11-23 07:55:23,814 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-11-23 07:55:23,814 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-11-23 07:55:23,814 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-11-23 07:55:23,815 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-11-23 07:55:23,815 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-11-23 07:55:23,815 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-11-23 07:55:23,816 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-11-23 07:55:23,816 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-11-23 07:55:23,816 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-11-23 07:55:23,819 [salt.utils.extmods][INFO    ][24112] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-11-23 07:55:23,822 [salt.utils.extmods][INFO    ][24112] Syncing sdb for environment 'base'
2017-11-23 07:55:23,822 [salt.utils.extmods][INFO    ][24112] Loading cache from salt://_sdb, for base)
2017-11-23 07:55:23,822 [salt.fileclient  ][INFO    ][24112] Caching directory '_sdb/' for environment 'base'
2017-11-23 07:55:23,860 [salt.utils.extmods][INFO    ][24112] Syncing grains for environment 'base'
2017-11-23 07:55:23,860 [salt.utils.extmods][INFO    ][24112] Loading cache from salt://_grains, for base)
2017-11-23 07:55:23,860 [salt.fileclient  ][INFO    ][24112] Caching directory '_grains/' for environment 'base'
2017-11-23 07:55:23,899 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-11-23 07:55:23,909 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-11-23 07:55:23,919 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-11-23 07:55:23,930 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-11-23 07:55:23,942 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-11-23 07:55:23,950 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-11-23 07:55:23,960 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-11-23 07:55:23,970 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-11-23 07:55:23,986 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-11-23 07:55:23,994 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-11-23 07:55:24,003 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-11-23 07:55:24,016 [salt.fileclient  ][INFO    ][24112] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-11-23 07:55:24,020 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-11-23 07:55:24,020 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-11-23 07:55:24,021 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-11-23 07:55:24,021 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-11-23 07:55:24,021 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-11-23 07:55:24,021 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-11-23 07:55:24,021 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-11-23 07:55:24,022 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-11-23 07:55:24,022 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-11-23 07:55:24,022 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-11-23 07:55:24,022 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-11-23 07:55:24,022 [salt.utils.extmods][INFO    ][24112] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-11-23 07:55:24,024 [salt.utils.extmods][INFO    ][24112] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-11-23 07:55:24,026 [salt.utils.extmods][INFO    ][24112] Syncing renderers for environment 'base'
2017-11-23 07:55:24,027 [salt.utils.extmods][INFO    ][24112] Loading cache from salt://_renderers, for base)
2017-11-23 07:55:24,027 [salt.fileclient  ][INFO    ][24112] Caching directory '_renderers/' for environment 'base'
2017-11-23 07:55:24,060 [salt.utils.extmods][INFO    ][24112] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-11-23 07:55:24,063 [salt.utils.extmods][INFO    ][24112] Syncing returners for environment 'base'
2017-11-23 07:55:24,063 [salt.utils.extmods][INFO    ][24112] Loading cache from salt://_returners, for base)
2017-11-23 07:55:24,063 [salt.fileclient  ][INFO    ][24112] Caching directory '_returners/' for environment 'base'
2017-11-23 07:55:24,091 [salt.utils.extmods][INFO    ][24112] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-11-23 07:55:24,094 [salt.utils.extmods][INFO    ][24112] Syncing output for environment 'base'
2017-11-23 07:55:24,094 [salt.utils.extmods][INFO    ][24112] Loading cache from salt://_output, for base)
2017-11-23 07:55:24,094 [salt.fileclient  ][INFO    ][24112] Caching directory '_output/' for environment 'base'
2017-11-23 07:55:24,128 [salt.utils.extmods][INFO    ][24112] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-11-23 07:55:24,131 [salt.utils.extmods][INFO    ][24112] Syncing utils for environment 'base'
2017-11-23 07:55:24,131 [salt.utils.extmods][INFO    ][24112] Loading cache from salt://_utils, for base)
2017-11-23 07:55:24,132 [salt.fileclient  ][INFO    ][24112] Caching directory '_utils/' for environment 'base'
2017-11-23 07:55:24,160 [salt.utils.extmods][INFO    ][24112] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-11-23 07:55:24,162 [salt.utils.extmods][INFO    ][24112] Syncing log_handlers for environment 'base'
2017-11-23 07:55:24,163 [salt.utils.extmods][INFO    ][24112] Loading cache from salt://_log_handlers, for base)
2017-11-23 07:55:24,163 [salt.fileclient  ][INFO    ][24112] Caching directory '_log_handlers/' for environment 'base'
2017-11-23 07:55:24,200 [salt.utils.extmods][INFO    ][24112] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-11-23 07:55:24,203 [salt.utils.extmods][INFO    ][24112] Syncing proxy for environment 'base'
2017-11-23 07:55:24,203 [salt.utils.extmods][INFO    ][24112] Loading cache from salt://_proxy, for base)
2017-11-23 07:55:24,203 [salt.fileclient  ][INFO    ][24112] Caching directory '_proxy/' for environment 'base'
2017-11-23 07:55:24,238 [salt.utils.extmods][INFO    ][24112] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-11-23 07:55:24,241 [salt.utils.extmods][INFO    ][24112] Syncing engines for environment 'base'
2017-11-23 07:55:24,241 [salt.utils.extmods][INFO    ][24112] Loading cache from salt://_engines, for base)
2017-11-23 07:55:24,241 [salt.fileclient  ][INFO    ][24112] Caching directory '_engines/' for environment 'base'
2017-11-23 07:55:24,275 [salt.minion      ][INFO    ][24112] Returning information for job: 20171123075519764988
2017-11-23 07:55:25,086 [salt.minion      ][INFO    ][24012] User sudo_ubuntu Executing command state.sls with jid 20171123075525078109
2017-11-23 07:55:25,095 [salt.minion      ][INFO    ][24177] Starting a new job with PID 24177
2017-11-23 07:55:25,694 [salt.state       ][INFO    ][24177] Loading fresh modules for state activity
2017-11-23 07:55:25,720 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-11-23 07:55:25,739 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-11-23 07:55:25,769 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-23 07:55:25,898 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-11-23 07:55:25,916 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-11-23 07:55:25,948 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-23 07:55:26,018 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-23 07:55:26,038 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-23 07:55:26,097 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-23 07:55:26,118 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-23 07:55:26,134 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-23 07:55:26,150 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-23 07:55:26,159 [salt.loaded.int.module.cmdmod][INFO    ][24177] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-23 07:55:26,181 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-23 07:55:26,199 [py.warnings      ][WARNING ][24177] /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-23 07:55:26,199 [salt.loaded.int.module.cmdmod][INFO    ][24177] Executing command 'salt-minion --version' in directory '/root'
2017-11-23 07:55:26,454 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-23 07:55:26,477 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-23 07:55:26,491 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-23 07:55:26,505 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-23 07:55:26,549 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-11-23 07:55:26,565 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-11-23 07:55:26,594 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-23 07:55:26,638 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-23 07:55:26,710 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-11-23 07:55:26,734 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-23 07:55:26,805 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-23 07:55:26,827 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-23 07:55:26,889 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-23 07:55:26,910 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-23 07:55:26,925 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-23 07:55:26,942 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-23 07:55:26,950 [salt.loaded.int.module.cmdmod][INFO    ][24177] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-23 07:55:26,973 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-23 07:55:26,992 [salt.loaded.int.module.cmdmod][INFO    ][24177] Executing command 'salt-minion --version' in directory '/root'
2017-11-23 07:55:27,245 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-23 07:55:27,261 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-23 07:55:27,271 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-23 07:55:27,282 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-23 07:55:27,324 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-11-23 07:55:27,336 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-11-23 07:55:27,647 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-23 07:55:27,690 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-23 07:55:27,770 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-11-23 07:55:27,850 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-23 07:55:28,224 [salt.state       ][INFO    ][24177] Running state [salt-minion] at time 07:55:28.224288
2017-11-23 07:55:28,225 [salt.state       ][INFO    ][24177] Executing state pkg.installed for salt-minion
2017-11-23 07:55:28,225 [salt.loaded.int.module.cmdmod][INFO    ][24177] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-23 07:55:28,500 [salt.state       ][INFO    ][24177] Package salt-minion is already installed
2017-11-23 07:55:28,500 [salt.state       ][INFO    ][24177] Completed state [salt-minion] at time 07:55:28.500128 duration_in_ms=275.839
2017-11-23 07:55:28,501 [salt.state       ][INFO    ][24177] Running state [salt_minion_dependency_packages] at time 07:55:28.500514
2017-11-23 07:55:28,501 [salt.state       ][INFO    ][24177] Executing state pkg.installed for salt_minion_dependency_packages
2017-11-23 07:55:28,505 [salt.state       ][INFO    ][24177] All specified packages are already installed
2017-11-23 07:55:28,505 [salt.state       ][INFO    ][24177] Completed state [salt_minion_dependency_packages] at time 07:55:28.504852 duration_in_ms=4.337
2017-11-23 07:55:28,507 [salt.state       ][INFO    ][24177] Running state [/etc/salt/minion.d/minion.conf] at time 07:55:28.506543
2017-11-23 07:55:28,507 [salt.state       ][INFO    ][24177] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-11-23 07:55:28,533 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-11-23 07:55:28,591 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-23 07:55:28,646 [salt.fileclient  ][INFO    ][24177] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-23 07:55:28,692 [salt.state       ][INFO    ][24177] File /etc/salt/minion.d/minion.conf is in the correct state
2017-11-23 07:55:28,693 [salt.state       ][INFO    ][24177] Completed state [/etc/salt/minion.d/minion.conf] at time 07:55:28.692631 duration_in_ms=186.087
2017-11-23 07:55:28,693 [salt.state       ][INFO    ][24177] Running state [/etc/salt/minion.d/_virt.conf] at time 07:55:28.693096
2017-11-23 07:55:28,693 [salt.state       ][INFO    ][24177] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-11-23 07:55:28,694 [salt.state       ][INFO    ][24177] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-11-23 07:55:28,694 [salt.state       ][INFO    ][24177] Completed state [/etc/salt/minion.d/_virt.conf] at time 07:55:28.694254 duration_in_ms=1.158
2017-11-23 07:55:28,696 [salt.state       ][INFO    ][24177] Running state [salt-minion] at time 07:55:28.695931
2017-11-23 07:55:28,696 [salt.state       ][INFO    ][24177] Executing state service.running for salt-minion
2017-11-23 07:55:28,697 [salt.loaded.int.module.cmdmod][INFO    ][24177] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-23 07:55:28,711 [salt.loaded.int.module.cmdmod][INFO    ][24177] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-11-23 07:55:28,718 [salt.loaded.int.module.cmdmod][INFO    ][24177] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-23 07:55:28,725 [salt.state       ][INFO    ][24177] The service salt-minion is already running
2017-11-23 07:55:28,725 [salt.state       ][INFO    ][24177] Completed state [salt-minion] at time 07:55:28.725207 duration_in_ms=29.275
2017-11-23 07:55:28,727 [salt.state       ][INFO    ][24177] Running state [/etc/salt/grains.d] at time 07:55:28.726871
2017-11-23 07:55:28,727 [salt.state       ][INFO    ][24177] Executing state file.directory for /etc/salt/grains.d
2017-11-23 07:55:28,728 [salt.state       ][INFO    ][24177] Directory /etc/salt/grains.d is in the correct state
2017-11-23 07:55:28,728 [salt.state       ][INFO    ][24177] Completed state [/etc/salt/grains.d] at time 07:55:28.727864 duration_in_ms=0.992
2017-11-23 07:55:28,728 [salt.state       ][INFO    ][24177] Running state [/etc/salt/grains] at time 07:55:28.728363
2017-11-23 07:55:28,729 [salt.state       ][INFO    ][24177] Executing state file.managed for /etc/salt/grains
2017-11-23 07:55:28,729 [salt.state       ][INFO    ][24177] File /etc/salt/grains exists with proper permissions. No changes made.
2017-11-23 07:55:28,729 [salt.state       ][INFO    ][24177] Completed state [/etc/salt/grains] at time 07:55:28.729049 duration_in_ms=0.686
2017-11-23 07:55:28,729 [salt.state       ][INFO    ][24177] Running state [/etc/salt/grains.d/placeholder] at time 07:55:28.729417
2017-11-23 07:55:28,730 [salt.state       ][INFO    ][24177] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-11-23 07:55:28,730 [salt.state       ][INFO    ][24177] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-11-23 07:55:28,730 [salt.state       ][INFO    ][24177] Completed state [/etc/salt/grains.d/placeholder] at time 07:55:28.730050 duration_in_ms=0.633
2017-11-23 07:55:28,730 [salt.state       ][INFO    ][24177] Running state [/etc/salt/grains.d/sphinx] at time 07:55:28.730380
2017-11-23 07:55:28,731 [salt.state       ][INFO    ][24177] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-11-23 07:55:28,732 [salt.state       ][INFO    ][24177] File changed:
--- 
+++ 
@@ -49,7 +49,6 @@
               - 127.0.0.1
               - 192.168.10.141
               - 192.168.11.2
-              - 192.168.122.1
         system:
           name: System
           param:

2017-11-23 07:55:28,732 [salt.state       ][INFO    ][24177] Completed state [/etc/salt/grains.d/sphinx] at time 07:55:28.732155 duration_in_ms=1.774
2017-11-23 07:55:28,733 [salt.state       ][INFO    ][24177] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 07:55:28.732844
2017-11-23 07:55:28,733 [salt.state       ][INFO    ][24177] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-23 07:55:28,733 [salt.state       ][INFO    ][24177] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-23 07:55:28,733 [salt.state       ][INFO    ][24177] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 07:55:28.733434 duration_in_ms=0.59
2017-11-23 07:55:28,734 [salt.state       ][INFO    ][24177] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 07:55:28.733583
2017-11-23 07:55:28,734 [salt.state       ][INFO    ][24177] 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-23 07:55:28,734 [salt.loaded.int.module.cmdmod][INFO    ][24177] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-11-23 07:55:28,807 [salt.state       ][INFO    ][24177] {'pid': 24255, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-11-23 07:55:28,807 [salt.state       ][INFO    ][24177] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 07:55:28.807093 duration_in_ms=73.497
2017-11-23 07:55:28,808 [salt.state       ][INFO    ][24177] Running state [/etc/salt/grains.d/dns_records] at time 07:55:28.807660
2017-11-23 07:55:28,808 [salt.state       ][INFO    ][24177] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-11-23 07:55:28,809 [salt.state       ][INFO    ][24177] File /etc/salt/grains.d/dns_records is in the correct state
2017-11-23 07:55:28,809 [salt.state       ][INFO    ][24177] Completed state [/etc/salt/grains.d/dns_records] at time 07:55:28.809041 duration_in_ms=1.381
2017-11-23 07:55:28,810 [salt.state       ][INFO    ][24177] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 07:55:28.809875
2017-11-23 07:55:28,810 [salt.state       ][INFO    ][24177] 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-23 07:55:28,810 [salt.state       ][INFO    ][24177] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-11-23 07:55:28,811 [salt.state       ][INFO    ][24177] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 07:55:28.810480 duration_in_ms=0.605
2017-11-23 07:55:28,811 [salt.state       ][INFO    ][24177] Running state [/etc/salt/grains.d/salt] at time 07:55:28.810836
2017-11-23 07:55:28,811 [salt.state       ][INFO    ][24177] Executing state file.managed for /etc/salt/grains.d/salt
2017-11-23 07:55:28,812 [salt.state       ][INFO    ][24177] File /etc/salt/grains.d/salt is in the correct state
2017-11-23 07:55:28,812 [salt.state       ][INFO    ][24177] Completed state [/etc/salt/grains.d/salt] at time 07:55:28.811877 duration_in_ms=1.041
2017-11-23 07:55:28,813 [salt.state       ][INFO    ][24177] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 07:55:28.812600
2017-11-23 07:55:28,813 [salt.state       ][INFO    ][24177] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-23 07:55:28,813 [salt.state       ][INFO    ][24177] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-23 07:55:28,813 [salt.state       ][INFO    ][24177] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 07:55:28.813208 duration_in_ms=0.608
2017-11-23 07:55:28,815 [salt.state       ][INFO    ][24177] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 07:55:28.814767
2017-11-23 07:55:28,815 [salt.state       ][INFO    ][24177] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-23 07:55:28,815 [salt.state       ][INFO    ][24177] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-23 07:55:28,815 [salt.state       ][INFO    ][24177] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 07:55:28.815360 duration_in_ms=0.593
2017-11-23 07:55:28,816 [salt.state       ][INFO    ][24177] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 07:55:28.815515
2017-11-23 07:55:28,816 [salt.state       ][INFO    ][24177] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-23 07:55:28,817 [salt.loaded.int.module.cmdmod][INFO    ][24177] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-11-23 07:55:28,824 [salt.state       ][INFO    ][24177] {'pid': 24257, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-11-23 07:55:28,824 [salt.state       ][INFO    ][24177] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 07:55:28.824007 duration_in_ms=8.492
2017-11-23 07:55:28,825 [salt.state       ][INFO    ][24177] Running state [mine.update] at time 07:55:28.824681
2017-11-23 07:55:28,825 [salt.state       ][INFO    ][24177] Executing state module.wait for mine.update
2017-11-23 07:55:28,825 [salt.state       ][INFO    ][24177] No changes made for mine.update
2017-11-23 07:55:28,825 [salt.state       ][INFO    ][24177] Completed state [mine.update] at time 07:55:28.825339 duration_in_ms=0.658
2017-11-23 07:55:28,826 [salt.state       ][INFO    ][24177] Running state [mine.update] at time 07:55:28.825497
2017-11-23 07:55:28,826 [salt.state       ][INFO    ][24177] Executing state module.mod_watch for mine.update
2017-11-23 07:55:29,342 [salt.state       ][INFO    ][24177] {'ret': True}
2017-11-23 07:55:29,343 [salt.state       ][INFO    ][24177] Completed state [mine.update] at time 07:55:29.342578 duration_in_ms=517.08
2017-11-23 07:55:29,343 [salt.state       ][INFO    ][24177] Running state [ca-certificates] at time 07:55:29.342841
2017-11-23 07:55:29,343 [salt.state       ][INFO    ][24177] Executing state pkg.installed for ca-certificates
2017-11-23 07:55:29,347 [salt.state       ][INFO    ][24177] Package ca-certificates is already installed
2017-11-23 07:55:29,347 [salt.state       ][INFO    ][24177] Completed state [ca-certificates] at time 07:55:29.347190 duration_in_ms=4.348
2017-11-23 07:55:29,348 [salt.state       ][INFO    ][24177] Running state [update-ca-certificates] at time 07:55:29.347824
2017-11-23 07:55:29,348 [salt.state       ][INFO    ][24177] Executing state cmd.wait for update-ca-certificates
2017-11-23 07:55:29,348 [salt.state       ][INFO    ][24177] No changes made for update-ca-certificates
2017-11-23 07:55:29,348 [salt.state       ][INFO    ][24177] Completed state [update-ca-certificates] at time 07:55:29.348400 duration_in_ms=0.575
2017-11-23 07:55:29,349 [salt.state       ][INFO    ][24177] Running state [libvirt-dev] at time 07:55:29.348577
2017-11-23 07:55:29,349 [salt.state       ][INFO    ][24177] Executing state pkg.installed for libvirt-dev
2017-11-23 07:55:29,352 [salt.state       ][INFO    ][24177] Package libvirt-dev is already installed
2017-11-23 07:55:29,353 [salt.state       ][INFO    ][24177] Completed state [libvirt-dev] at time 07:55:29.352536 duration_in_ms=3.96
2017-11-23 07:55:29,353 [salt.state       ][INFO    ][24177] Running state [pkg-config] at time 07:55:29.352727
2017-11-23 07:55:29,353 [salt.state       ][INFO    ][24177] Executing state pkg.installed for pkg-config
2017-11-23 07:55:29,357 [salt.state       ][INFO    ][24177] Package pkg-config is already installed
2017-11-23 07:55:29,357 [salt.state       ][INFO    ][24177] Completed state [pkg-config] at time 07:55:29.356721 duration_in_ms=3.994
2017-11-23 07:55:29,357 [salt.state       ][INFO    ][24177] Running state [virtng.init] at time 07:55:29.356915
2017-11-23 07:55:29,357 [salt.state       ][INFO    ][24177] Executing state module.run for virtng.init
2017-11-23 07:55:29,418 [salt.loaded.int.module.cmdmod][INFO    ][24177] Executing command ['git', '--version'] in directory '/root'
2017-11-23 07:55:29,495 [salt.loaded.int.module.cmdmod][INFO    ][24177] Executing command 'virsh list --all --name| grep -E "^prx01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-23 07:55:29,512 [salt.state       ][INFO    ][24177] unless execution succeeded
2017-11-23 07:55:29,512 [salt.state       ][INFO    ][24177] Completed state [virtng.init] at time 07:55:29.512036 duration_in_ms=155.121
2017-11-23 07:55:29,512 [salt.state       ][INFO    ][24177] Running state [virt.set_autostart] at time 07:55:29.512270
2017-11-23 07:55:29,512 [salt.state       ][INFO    ][24177] Executing state module.run for virt.set_autostart
2017-11-23 07:55:29,515 [salt.loaded.int.module.cmdmod][INFO    ][24177] Executing command 'virsh list --autostart --name| grep -E "^prx01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-23 07:55:29,532 [salt.state       ][INFO    ][24177] unless execution succeeded
2017-11-23 07:55:29,532 [salt.state       ][INFO    ][24177] Completed state [virt.set_autostart] at time 07:55:29.532161 duration_in_ms=19.891
2017-11-23 07:55:29,532 [salt.state       ][INFO    ][24177] Running state [virtng.init] at time 07:55:29.532432
2017-11-23 07:55:29,533 [salt.state       ][INFO    ][24177] Executing state module.run for virtng.init
2017-11-23 07:55:29,535 [salt.loaded.int.module.cmdmod][INFO    ][24177] Executing command 'virsh list --all --name| grep -E "^ctl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-23 07:55:29,550 [salt.state       ][INFO    ][24177] unless execution succeeded
2017-11-23 07:55:29,550 [salt.state       ][INFO    ][24177] Completed state [virtng.init] at time 07:55:29.550144 duration_in_ms=17.712
2017-11-23 07:55:29,550 [salt.state       ][INFO    ][24177] Running state [virt.set_autostart] at time 07:55:29.550390
2017-11-23 07:55:29,551 [salt.state       ][INFO    ][24177] Executing state module.run for virt.set_autostart
2017-11-23 07:55:29,553 [salt.loaded.int.module.cmdmod][INFO    ][24177] Executing command 'virsh list --autostart --name| grep -E "^ctl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-23 07:55:29,568 [salt.state       ][INFO    ][24177] unless execution succeeded
2017-11-23 07:55:29,568 [salt.state       ][INFO    ][24177] Completed state [virt.set_autostart] at time 07:55:29.568107 duration_in_ms=17.717
2017-11-23 07:55:29,568 [salt.state       ][INFO    ][24177] Running state [virtng.init] at time 07:55:29.568348
2017-11-23 07:55:29,569 [salt.state       ][INFO    ][24177] Executing state module.run for virtng.init
2017-11-23 07:55:29,571 [salt.loaded.int.module.cmdmod][INFO    ][24177] Executing command 'virsh list --all --name| grep -E "^mdb01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-23 07:55:29,586 [salt.state       ][INFO    ][24177] unless execution succeeded
2017-11-23 07:55:29,586 [salt.state       ][INFO    ][24177] Completed state [virtng.init] at time 07:55:29.586085 duration_in_ms=17.736
2017-11-23 07:55:29,586 [salt.state       ][INFO    ][24177] Running state [virt.set_autostart] at time 07:55:29.586309
2017-11-23 07:55:29,587 [salt.state       ][INFO    ][24177] Executing state module.run for virt.set_autostart
2017-11-23 07:55:29,589 [salt.loaded.int.module.cmdmod][INFO    ][24177] Executing command 'virsh list --autostart --name| grep -E "^mdb01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-23 07:55:29,604 [salt.state       ][INFO    ][24177] unless execution succeeded
2017-11-23 07:55:29,604 [salt.state       ][INFO    ][24177] Completed state [virt.set_autostart] at time 07:55:29.604386 duration_in_ms=18.077
2017-11-23 07:55:29,605 [salt.state       ][INFO    ][24177] Running state [virtng.init] at time 07:55:29.604635
2017-11-23 07:55:29,605 [salt.state       ][INFO    ][24177] Executing state module.run for virtng.init
2017-11-23 07:55:29,608 [salt.loaded.int.module.cmdmod][INFO    ][24177] Executing command 'virsh list --all --name| grep -E "^msg01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-23 07:55:29,622 [salt.state       ][INFO    ][24177] unless execution succeeded
2017-11-23 07:55:29,622 [salt.state       ][INFO    ][24177] Completed state [virtng.init] at time 07:55:29.622220 duration_in_ms=17.585
2017-11-23 07:55:29,622 [salt.state       ][INFO    ][24177] Running state [virt.set_autostart] at time 07:55:29.622443
2017-11-23 07:55:29,623 [salt.state       ][INFO    ][24177] Executing state module.run for virt.set_autostart
2017-11-23 07:55:29,625 [salt.loaded.int.module.cmdmod][INFO    ][24177] Executing command 'virsh list --autostart --name| grep -E "^msg01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-23 07:55:29,640 [salt.state       ][INFO    ][24177] unless execution succeeded
2017-11-23 07:55:29,640 [salt.state       ][INFO    ][24177] Completed state [virt.set_autostart] at time 07:55:29.640209 duration_in_ms=17.766
2017-11-23 07:55:29,640 [salt.state       ][INFO    ][24177] Running state [virtng.init] at time 07:55:29.640464
2017-11-23 07:55:29,641 [salt.state       ][INFO    ][24177] Executing state module.run for virtng.init
2017-11-23 07:55:29,643 [salt.loaded.int.module.cmdmod][INFO    ][24177] Executing command 'virsh list --all --name| grep -E "^dbs01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-23 07:55:29,658 [salt.state       ][INFO    ][24177] unless execution succeeded
2017-11-23 07:55:29,658 [salt.state       ][INFO    ][24177] Completed state [virtng.init] at time 07:55:29.657782 duration_in_ms=17.318
2017-11-23 07:55:29,658 [salt.state       ][INFO    ][24177] Running state [virt.set_autostart] at time 07:55:29.658058
2017-11-23 07:55:29,658 [salt.state       ][INFO    ][24177] Executing state module.run for virt.set_autostart
2017-11-23 07:55:29,661 [salt.loaded.int.module.cmdmod][INFO    ][24177] Executing command 'virsh list --autostart --name| grep -E "^dbs01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-23 07:55:29,675 [salt.state       ][INFO    ][24177] unless execution succeeded
2017-11-23 07:55:29,676 [salt.state       ][INFO    ][24177] Completed state [virt.set_autostart] at time 07:55:29.675565 duration_in_ms=17.507
2017-11-23 07:55:29,678 [salt.minion      ][INFO    ][24177] Returning information for job: 20171123075525078109
2017-11-23 07:55:57,181 [salt.minion      ][INFO    ][24012] User sudo_ubuntu Executing command state.sls with jid 20171123075557173246
2017-11-23 07:55:57,193 [salt.minion      ][INFO    ][24311] Starting a new job with PID 24311
2017-11-23 07:55:59,799 [salt.state       ][INFO    ][24311] Loading fresh modules for state activity
2017-11-23 07:55:59,834 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-11-23 07:55:59,853 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-11-23 07:55:59,913 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-23 07:55:59,997 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-11-23 07:56:00,013 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-11-23 07:56:00,050 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-23 07:56:00,117 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-23 07:56:00,136 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-23 07:56:00,193 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-23 07:56:00,215 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-23 07:56:00,233 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-23 07:56:00,250 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-23 07:56:00,259 [salt.loaded.int.module.cmdmod][INFO    ][24311] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-23 07:56:00,288 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-23 07:56:00,307 [py.warnings      ][WARNING ][24311] /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-23 07:56:00,307 [salt.loaded.int.module.cmdmod][INFO    ][24311] Executing command 'salt-minion --version' in directory '/root'
2017-11-23 07:56:00,564 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-23 07:56:00,585 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-23 07:56:00,596 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-23 07:56:00,613 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-23 07:56:00,655 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-11-23 07:56:00,672 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-11-23 07:56:00,701 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-23 07:56:00,742 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-23 07:56:00,813 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-11-23 07:56:00,836 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-23 07:56:00,904 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-23 07:56:00,925 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-23 07:56:00,981 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-23 07:56:01,000 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-23 07:56:01,015 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-23 07:56:01,033 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-23 07:56:01,041 [salt.loaded.int.module.cmdmod][INFO    ][24311] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-23 07:56:01,065 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-23 07:56:01,083 [salt.loaded.int.module.cmdmod][INFO    ][24311] Executing command 'salt-minion --version' in directory '/root'
2017-11-23 07:56:01,344 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-23 07:56:01,365 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-23 07:56:01,377 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-23 07:56:01,388 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-23 07:56:01,431 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-11-23 07:56:01,452 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-11-23 07:56:01,481 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-23 07:56:01,527 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-23 07:56:01,608 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-11-23 07:56:01,686 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-23 07:56:02,014 [salt.state       ][INFO    ][24311] Running state [salt-minion] at time 07:56:02.014400
2017-11-23 07:56:02,015 [salt.state       ][INFO    ][24311] Executing state pkg.installed for salt-minion
2017-11-23 07:56:02,015 [salt.loaded.int.module.cmdmod][INFO    ][24311] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-23 07:56:02,267 [salt.state       ][INFO    ][24311] Package salt-minion is already installed
2017-11-23 07:56:02,267 [salt.state       ][INFO    ][24311] Completed state [salt-minion] at time 07:56:02.266791 duration_in_ms=252.392
2017-11-23 07:56:02,267 [salt.state       ][INFO    ][24311] Running state [salt_minion_dependency_packages] at time 07:56:02.267054
2017-11-23 07:56:02,267 [salt.state       ][INFO    ][24311] Executing state pkg.installed for salt_minion_dependency_packages
2017-11-23 07:56:02,271 [salt.state       ][INFO    ][24311] All specified packages are already installed
2017-11-23 07:56:02,271 [salt.state       ][INFO    ][24311] Completed state [salt_minion_dependency_packages] at time 07:56:02.271248 duration_in_ms=4.194
2017-11-23 07:56:02,273 [salt.state       ][INFO    ][24311] Running state [/etc/salt/minion.d/minion.conf] at time 07:56:02.272857
2017-11-23 07:56:02,273 [salt.state       ][INFO    ][24311] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-11-23 07:56:02,304 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-11-23 07:56:02,365 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-23 07:56:02,420 [salt.fileclient  ][INFO    ][24311] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-23 07:56:02,466 [salt.state       ][INFO    ][24311] File /etc/salt/minion.d/minion.conf is in the correct state
2017-11-23 07:56:02,467 [salt.state       ][INFO    ][24311] Completed state [/etc/salt/minion.d/minion.conf] at time 07:56:02.466580 duration_in_ms=193.724
2017-11-23 07:56:02,467 [salt.state       ][INFO    ][24311] Running state [/etc/salt/minion.d/_virt.conf] at time 07:56:02.466961
2017-11-23 07:56:02,467 [salt.state       ][INFO    ][24311] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-11-23 07:56:02,468 [salt.state       ][INFO    ][24311] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-11-23 07:56:02,468 [salt.state       ][INFO    ][24311] Completed state [/etc/salt/minion.d/_virt.conf] at time 07:56:02.468022 duration_in_ms=1.061
2017-11-23 07:56:02,470 [salt.state       ][INFO    ][24311] Running state [salt-minion] at time 07:56:02.469709
2017-11-23 07:56:02,470 [salt.state       ][INFO    ][24311] Executing state service.running for salt-minion
2017-11-23 07:56:02,470 [salt.loaded.int.module.cmdmod][INFO    ][24311] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-23 07:56:02,482 [salt.loaded.int.module.cmdmod][INFO    ][24311] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-11-23 07:56:02,488 [salt.loaded.int.module.cmdmod][INFO    ][24311] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-23 07:56:02,493 [salt.state       ][INFO    ][24311] The service salt-minion is already running
2017-11-23 07:56:02,494 [salt.state       ][INFO    ][24311] Completed state [salt-minion] at time 07:56:02.493529 duration_in_ms=23.82
2017-11-23 07:56:02,495 [salt.state       ][INFO    ][24311] Running state [/etc/salt/grains.d] at time 07:56:02.495074
2017-11-23 07:56:02,495 [salt.state       ][INFO    ][24311] Executing state file.directory for /etc/salt/grains.d
2017-11-23 07:56:02,496 [salt.state       ][INFO    ][24311] Directory /etc/salt/grains.d is in the correct state
2017-11-23 07:56:02,496 [salt.state       ][INFO    ][24311] Completed state [/etc/salt/grains.d] at time 07:56:02.496097 duration_in_ms=1.022
2017-11-23 07:56:02,497 [salt.state       ][INFO    ][24311] Running state [/etc/salt/grains] at time 07:56:02.496665
2017-11-23 07:56:02,497 [salt.state       ][INFO    ][24311] Executing state file.managed for /etc/salt/grains
2017-11-23 07:56:02,497 [salt.state       ][INFO    ][24311] File /etc/salt/grains exists with proper permissions. No changes made.
2017-11-23 07:56:02,498 [salt.state       ][INFO    ][24311] Completed state [/etc/salt/grains] at time 07:56:02.497481 duration_in_ms=0.816
2017-11-23 07:56:02,498 [salt.state       ][INFO    ][24311] Running state [/etc/salt/grains.d/placeholder] at time 07:56:02.497853
2017-11-23 07:56:02,498 [salt.state       ][INFO    ][24311] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-11-23 07:56:02,498 [salt.state       ][INFO    ][24311] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-11-23 07:56:02,499 [salt.state       ][INFO    ][24311] Completed state [/etc/salt/grains.d/placeholder] at time 07:56:02.498579 duration_in_ms=0.726
2017-11-23 07:56:02,499 [salt.state       ][INFO    ][24311] Running state [/etc/salt/grains.d/sphinx] at time 07:56:02.498948
2017-11-23 07:56:02,499 [salt.state       ][INFO    ][24311] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-11-23 07:56:02,500 [salt.state       ][INFO    ][24311] File /etc/salt/grains.d/sphinx is in the correct state
2017-11-23 07:56:02,500 [salt.state       ][INFO    ][24311] Completed state [/etc/salt/grains.d/sphinx] at time 07:56:02.500056 duration_in_ms=1.108
2017-11-23 07:56:02,501 [salt.state       ][INFO    ][24311] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 07:56:02.500789
2017-11-23 07:56:02,501 [salt.state       ][INFO    ][24311] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-23 07:56:02,501 [salt.state       ][INFO    ][24311] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-23 07:56:02,501 [salt.state       ][INFO    ][24311] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 07:56:02.501408 duration_in_ms=0.62
2017-11-23 07:56:02,502 [salt.state       ][INFO    ][24311] Running state [/etc/salt/grains.d/dns_records] at time 07:56:02.501777
2017-11-23 07:56:02,502 [salt.state       ][INFO    ][24311] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-11-23 07:56:02,503 [salt.state       ][INFO    ][24311] File /etc/salt/grains.d/dns_records is in the correct state
2017-11-23 07:56:02,503 [salt.state       ][INFO    ][24311] Completed state [/etc/salt/grains.d/dns_records] at time 07:56:02.502777 duration_in_ms=0.999
2017-11-23 07:56:02,504 [salt.state       ][INFO    ][24311] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 07:56:02.503521
2017-11-23 07:56:02,504 [salt.state       ][INFO    ][24311] 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-23 07:56:02,504 [salt.state       ][INFO    ][24311] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-11-23 07:56:02,504 [salt.state       ][INFO    ][24311] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 07:56:02.504103 duration_in_ms=0.581
2017-11-23 07:56:02,504 [salt.state       ][INFO    ][24311] Running state [/etc/salt/grains.d/salt] at time 07:56:02.504456
2017-11-23 07:56:02,505 [salt.state       ][INFO    ][24311] Executing state file.managed for /etc/salt/grains.d/salt
2017-11-23 07:56:02,505 [salt.state       ][INFO    ][24311] File /etc/salt/grains.d/salt is in the correct state
2017-11-23 07:56:02,506 [salt.state       ][INFO    ][24311] Completed state [/etc/salt/grains.d/salt] at time 07:56:02.505529 duration_in_ms=1.074
2017-11-23 07:56:02,506 [salt.state       ][INFO    ][24311] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 07:56:02.506243
2017-11-23 07:56:02,506 [salt.state       ][INFO    ][24311] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-23 07:56:02,507 [salt.state       ][INFO    ][24311] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-23 07:56:02,507 [salt.state       ][INFO    ][24311] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 07:56:02.506819 duration_in_ms=0.575
2017-11-23 07:56:02,508 [salt.state       ][INFO    ][24311] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 07:56:02.508354
2017-11-23 07:56:02,509 [salt.state       ][INFO    ][24311] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-23 07:56:02,509 [salt.state       ][INFO    ][24311] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-23 07:56:02,509 [salt.state       ][INFO    ][24311] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 07:56:02.508945 duration_in_ms=0.591
2017-11-23 07:56:02,510 [salt.state       ][INFO    ][24311] Running state [mine.update] at time 07:56:02.509533
2017-11-23 07:56:02,510 [salt.state       ][INFO    ][24311] Executing state module.wait for mine.update
2017-11-23 07:56:02,510 [salt.state       ][INFO    ][24311] No changes made for mine.update
2017-11-23 07:56:02,510 [salt.state       ][INFO    ][24311] Completed state [mine.update] at time 07:56:02.510074 duration_in_ms=0.541
2017-11-23 07:56:02,510 [salt.state       ][INFO    ][24311] Running state [ca-certificates] at time 07:56:02.510248
2017-11-23 07:56:02,510 [salt.state       ][INFO    ][24311] Executing state pkg.installed for ca-certificates
2017-11-23 07:56:02,514 [salt.state       ][INFO    ][24311] Package ca-certificates is already installed
2017-11-23 07:56:02,515 [salt.state       ][INFO    ][24311] Completed state [ca-certificates] at time 07:56:02.514569 duration_in_ms=4.321
2017-11-23 07:56:02,515 [salt.state       ][INFO    ][24311] Running state [update-ca-certificates] at time 07:56:02.515141
2017-11-23 07:56:02,515 [salt.state       ][INFO    ][24311] Executing state cmd.wait for update-ca-certificates
2017-11-23 07:56:02,516 [salt.state       ][INFO    ][24311] No changes made for update-ca-certificates
2017-11-23 07:56:02,516 [salt.state       ][INFO    ][24311] Completed state [update-ca-certificates] at time 07:56:02.515701 duration_in_ms=0.559
2017-11-23 07:56:02,516 [salt.state       ][INFO    ][24311] Running state [libvirt-dev] at time 07:56:02.515874
2017-11-23 07:56:02,516 [salt.state       ][INFO    ][24311] Executing state pkg.installed for libvirt-dev
2017-11-23 07:56:02,520 [salt.state       ][INFO    ][24311] Package libvirt-dev is already installed
2017-11-23 07:56:02,520 [salt.state       ][INFO    ][24311] Completed state [libvirt-dev] at time 07:56:02.519970 duration_in_ms=4.097
2017-11-23 07:56:02,520 [salt.state       ][INFO    ][24311] Running state [pkg-config] at time 07:56:02.520161
2017-11-23 07:56:02,520 [salt.state       ][INFO    ][24311] Executing state pkg.installed for pkg-config
2017-11-23 07:56:02,524 [salt.state       ][INFO    ][24311] Package pkg-config is already installed
2017-11-23 07:56:02,524 [salt.state       ][INFO    ][24311] Completed state [pkg-config] at time 07:56:02.524166 duration_in_ms=4.006
2017-11-23 07:56:02,524 [salt.state       ][INFO    ][24311] Running state [virtng.init] at time 07:56:02.524364
2017-11-23 07:56:02,525 [salt.state       ][INFO    ][24311] Executing state module.run for virtng.init
2017-11-23 07:56:02,598 [salt.loaded.int.module.cmdmod][INFO    ][24311] Executing command ['git', '--version'] in directory '/root'
2017-11-23 07:56:02,646 [salt.loaded.int.module.cmdmod][INFO    ][24311] Executing command 'virsh list --all --name| grep -E "^prx01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-23 07:56:02,661 [salt.state       ][INFO    ][24311] unless execution succeeded
2017-11-23 07:56:02,662 [salt.state       ][INFO    ][24311] Completed state [virtng.init] at time 07:56:02.661552 duration_in_ms=137.187
2017-11-23 07:56:02,662 [salt.state       ][INFO    ][24311] Running state [virt.set_autostart] at time 07:56:02.661861
2017-11-23 07:56:02,662 [salt.state       ][INFO    ][24311] Executing state module.run for virt.set_autostart
2017-11-23 07:56:02,665 [salt.loaded.int.module.cmdmod][INFO    ][24311] Executing command 'virsh list --autostart --name| grep -E "^prx01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-23 07:56:02,682 [salt.state       ][INFO    ][24311] unless execution succeeded
2017-11-23 07:56:02,682 [salt.state       ][INFO    ][24311] Completed state [virt.set_autostart] at time 07:56:02.682011 duration_in_ms=20.15
2017-11-23 07:56:02,682 [salt.state       ][INFO    ][24311] Running state [virtng.init] at time 07:56:02.682283
2017-11-23 07:56:02,683 [salt.state       ][INFO    ][24311] Executing state module.run for virtng.init
2017-11-23 07:56:02,685 [salt.loaded.int.module.cmdmod][INFO    ][24311] Executing command 'virsh list --all --name| grep -E "^ctl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-23 07:56:02,701 [salt.state       ][INFO    ][24311] unless execution succeeded
2017-11-23 07:56:02,702 [salt.state       ][INFO    ][24311] Completed state [virtng.init] at time 07:56:02.701549 duration_in_ms=19.265
2017-11-23 07:56:02,702 [salt.state       ][INFO    ][24311] Running state [virt.set_autostart] at time 07:56:02.701806
2017-11-23 07:56:02,702 [salt.state       ][INFO    ][24311] Executing state module.run for virt.set_autostart
2017-11-23 07:56:02,705 [salt.loaded.int.module.cmdmod][INFO    ][24311] Executing command 'virsh list --autostart --name| grep -E "^ctl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-23 07:56:02,720 [salt.state       ][INFO    ][24311] unless execution succeeded
2017-11-23 07:56:02,720 [salt.state       ][INFO    ][24311] Completed state [virt.set_autostart] at time 07:56:02.719872 duration_in_ms=18.066
2017-11-23 07:56:02,720 [salt.state       ][INFO    ][24311] Running state [virtng.init] at time 07:56:02.720121
2017-11-23 07:56:02,720 [salt.state       ][INFO    ][24311] Executing state module.run for virtng.init
2017-11-23 07:56:02,723 [salt.loaded.int.module.cmdmod][INFO    ][24311] Executing command 'virsh list --all --name| grep -E "^mdb01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-23 07:56:02,738 [salt.state       ][INFO    ][24311] unless execution succeeded
2017-11-23 07:56:02,738 [salt.state       ][INFO    ][24311] Completed state [virtng.init] at time 07:56:02.738358 duration_in_ms=18.236
2017-11-23 07:56:02,739 [salt.state       ][INFO    ][24311] Running state [virt.set_autostart] at time 07:56:02.738609
2017-11-23 07:56:02,739 [salt.state       ][INFO    ][24311] Executing state module.run for virt.set_autostart
2017-11-23 07:56:02,742 [salt.loaded.int.module.cmdmod][INFO    ][24311] Executing command 'virsh list --autostart --name| grep -E "^mdb01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-23 07:56:02,757 [salt.state       ][INFO    ][24311] unless execution succeeded
2017-11-23 07:56:02,757 [salt.state       ][INFO    ][24311] Completed state [virt.set_autostart] at time 07:56:02.757278 duration_in_ms=18.669
2017-11-23 07:56:02,758 [salt.state       ][INFO    ][24311] Running state [virtng.init] at time 07:56:02.757526
2017-11-23 07:56:02,758 [salt.state       ][INFO    ][24311] Executing state module.run for virtng.init
2017-11-23 07:56:02,760 [salt.loaded.int.module.cmdmod][INFO    ][24311] Executing command 'virsh list --all --name| grep -E "^msg01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-23 07:56:02,775 [salt.state       ][INFO    ][24311] unless execution succeeded
2017-11-23 07:56:02,775 [salt.state       ][INFO    ][24311] Completed state [virtng.init] at time 07:56:02.775214 duration_in_ms=17.687
2017-11-23 07:56:02,776 [salt.state       ][INFO    ][24311] Running state [virt.set_autostart] at time 07:56:02.775486
2017-11-23 07:56:02,776 [salt.state       ][INFO    ][24311] Executing state module.run for virt.set_autostart
2017-11-23 07:56:02,778 [salt.loaded.int.module.cmdmod][INFO    ][24311] Executing command 'virsh list --autostart --name| grep -E "^msg01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-23 07:56:02,794 [salt.state       ][INFO    ][24311] unless execution succeeded
2017-11-23 07:56:02,795 [salt.state       ][INFO    ][24311] Completed state [virt.set_autostart] at time 07:56:02.794512 duration_in_ms=19.026
2017-11-23 07:56:02,795 [salt.state       ][INFO    ][24311] Running state [virtng.init] at time 07:56:02.794758
2017-11-23 07:56:02,795 [salt.state       ][INFO    ][24311] Executing state module.run for virtng.init
2017-11-23 07:56:02,798 [salt.loaded.int.module.cmdmod][INFO    ][24311] Executing command 'virsh list --all --name| grep -E "^dbs01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-23 07:56:02,812 [salt.state       ][INFO    ][24311] unless execution succeeded
2017-11-23 07:56:02,813 [salt.state       ][INFO    ][24311] Completed state [virtng.init] at time 07:56:02.812519 duration_in_ms=17.761
2017-11-23 07:56:02,813 [salt.state       ][INFO    ][24311] Running state [virt.set_autostart] at time 07:56:02.812765
2017-11-23 07:56:02,813 [salt.state       ][INFO    ][24311] Executing state module.run for virt.set_autostart
2017-11-23 07:56:02,816 [salt.loaded.int.module.cmdmod][INFO    ][24311] Executing command 'virsh list --autostart --name| grep -E "^dbs01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-23 07:56:02,831 [salt.state       ][INFO    ][24311] unless execution succeeded
2017-11-23 07:56:02,831 [salt.state       ][INFO    ][24311] Completed state [virt.set_autostart] at time 07:56:02.830939 duration_in_ms=18.174
2017-11-23 07:56:02,834 [salt.minion      ][INFO    ][24311] Returning information for job: 20171123075557173246
2017-11-23 07:56:04,378 [salt.minion      ][INFO    ][24012] User sudo_ubuntu Executing command pillar.get with jid 20171123075604371904
2017-11-23 07:56:04,388 [salt.minion      ][INFO    ][24405] Starting a new job with PID 24405
2017-11-23 07:56:04,391 [salt.minion      ][INFO    ][24405] Returning information for job: 20171123075604371904
2017-11-23 07:56:23,606 [salt.minion      ][INFO    ][24012] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171123075623594649
2017-11-23 07:56:23,618 [salt.minion      ][INFO    ][24422] Starting a new job with PID 24422
2017-11-23 07:56:27,128 [salt.state       ][INFO    ][24422] Loading fresh modules for state activity
2017-11-23 07:56:27,152 [salt.state       ][ERROR   ][24422] No contents found in top file
2017-11-23 07:56:27,153 [salt.utils.extmods][INFO    ][24422] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-11-23 07:56:27,156 [salt.utils.extmods][INFO    ][24422] Syncing beacons for environment 'base'
2017-11-23 07:56:27,156 [salt.utils.extmods][INFO    ][24422] Loading cache from salt://_beacons, for base)
2017-11-23 07:56:27,156 [salt.fileclient  ][INFO    ][24422] Caching directory '_beacons/' for environment 'base'
2017-11-23 07:56:27,207 [salt.utils.extmods][INFO    ][24422] Syncing modules for environment 'base'
2017-11-23 07:56:27,207 [salt.utils.extmods][INFO    ][24422] Loading cache from salt://_modules, for base)
2017-11-23 07:56:27,207 [salt.fileclient  ][INFO    ][24422] Caching directory '_modules/' for environment 'base'
2017-11-23 07:56:27,260 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-11-23 07:56:27,269 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-11-23 07:56:27,280 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-11-23 07:56:27,289 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-11-23 07:56:28,096 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-11-23 07:56:28,327 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-11-23 07:56:28,338 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-11-23 07:56:28,652 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-11-23 07:56:29,034 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-11-23 07:56:29,063 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-11-23 07:56:29,077 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-11-23 07:56:29,091 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-11-23 07:56:29,106 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-11-23 07:56:29,118 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-11-23 07:56:29,133 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-11-23 07:56:29,154 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-11-23 07:56:29,167 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-11-23 07:56:29,185 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-11-23 07:56:29,200 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-11-23 07:56:29,212 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-11-23 07:56:29,225 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-11-23 07:56:29,244 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-11-23 07:56:29,260 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-11-23 07:56:29,273 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-11-23 07:56:29,286 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-11-23 07:56:29,296 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-11-23 07:56:29,312 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-11-23 07:56:29,325 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-11-23 07:56:29,347 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-11-23 07:56:29,382 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-11-23 07:56:29,394 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-11-23 07:56:29,408 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-11-23 07:56:29,420 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-11-23 07:56:29,424 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-11-23 07:56:29,425 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-11-23 07:56:29,425 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-11-23 07:56:29,426 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-11-23 07:56:29,426 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-11-23 07:56:29,426 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-11-23 07:56:29,427 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-11-23 07:56:29,427 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-11-23 07:56:29,427 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-11-23 07:56:29,428 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-11-23 07:56:29,428 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-11-23 07:56:29,429 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-11-23 07:56:29,429 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-11-23 07:56:29,429 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-11-23 07:56:29,430 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-11-23 07:56:29,430 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-11-23 07:56:29,430 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-11-23 07:56:29,431 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-11-23 07:56:29,431 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2017-11-23 07:56:29,431 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-11-23 07:56:29,431 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-11-23 07:56:29,432 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-11-23 07:56:29,432 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-11-23 07:56:29,433 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-11-23 07:56:29,433 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-11-23 07:56:29,434 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-11-23 07:56:29,434 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-11-23 07:56:29,434 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-11-23 07:56:29,435 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-11-23 07:56:29,435 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-11-23 07:56:29,435 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-11-23 07:56:29,435 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-11-23 07:56:29,436 [salt.utils.extmods][INFO    ][24422] 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-23 07:56:29,436 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-11-23 07:56:29,436 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-11-23 07:56:29,443 [salt.utils.extmods][INFO    ][24422] Syncing states for environment 'base'
2017-11-23 07:56:29,443 [salt.utils.extmods][INFO    ][24422] Loading cache from salt://_states, for base)
2017-11-23 07:56:29,444 [salt.fileclient  ][INFO    ][24422] Caching directory '_states/' for environment 'base'
2017-11-23 07:56:29,498 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-11-23 07:56:29,569 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-11-23 07:56:29,591 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-11-23 07:56:29,605 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-11-23 07:56:29,622 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-11-23 07:56:29,636 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-11-23 07:56:29,646 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-11-23 07:56:29,666 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-11-23 07:56:29,683 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-11-23 07:56:29,709 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-11-23 07:56:29,730 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-11-23 07:56:29,810 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_states/jenkins_globalenvprop.py'
2017-11-23 07:56:29,843 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-11-23 07:56:29,857 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-11-23 07:56:29,869 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-11-23 07:56:29,884 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-11-23 07:56:29,899 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-11-23 07:56:29,919 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-11-23 07:56:29,931 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-11-23 07:56:29,944 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-11-23 07:56:29,960 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-11-23 07:56:30,040 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-11-23 07:56:30,059 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-11-23 07:56:30,076 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-11-23 07:56:30,104 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-11-23 07:56:30,126 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-11-23 07:56:30,146 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-11-23 07:56:30,156 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-11-23 07:56:30,170 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-11-23 07:56:30,221 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-11-23 07:56:30,225 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-11-23 07:56:30,225 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-11-23 07:56:30,226 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-11-23 07:56:30,226 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-11-23 07:56:30,226 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-11-23 07:56:30,227 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-11-23 07:56:30,227 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-11-23 07:56:30,227 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-11-23 07:56:30,228 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-11-23 07:56:30,228 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-11-23 07:56:30,228 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-11-23 07:56:30,228 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_states/jenkins_globalenvprop.py' to '/var/cache/salt/minion/extmods/states/jenkins_globalenvprop.py'
2017-11-23 07:56:30,229 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-11-23 07:56:30,229 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-11-23 07:56:30,229 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-11-23 07:56:30,229 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-11-23 07:56:30,230 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-11-23 07:56:30,230 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-11-23 07:56:30,230 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-11-23 07:56:30,230 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-11-23 07:56:30,231 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-11-23 07:56:30,231 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-11-23 07:56:30,231 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-11-23 07:56:30,231 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-11-23 07:56:30,232 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-11-23 07:56:30,232 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-11-23 07:56:30,232 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-11-23 07:56:30,232 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-11-23 07:56:30,233 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-11-23 07:56:30,233 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-11-23 07:56:30,233 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-11-23 07:56:30,236 [salt.utils.extmods][INFO    ][24422] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-11-23 07:56:30,239 [salt.utils.extmods][INFO    ][24422] Syncing sdb for environment 'base'
2017-11-23 07:56:30,239 [salt.utils.extmods][INFO    ][24422] Loading cache from salt://_sdb, for base)
2017-11-23 07:56:30,239 [salt.fileclient  ][INFO    ][24422] Caching directory '_sdb/' for environment 'base'
2017-11-23 07:56:30,299 [salt.utils.extmods][INFO    ][24422] Syncing grains for environment 'base'
2017-11-23 07:56:30,299 [salt.utils.extmods][INFO    ][24422] Loading cache from salt://_grains, for base)
2017-11-23 07:56:30,299 [salt.fileclient  ][INFO    ][24422] Caching directory '_grains/' for environment 'base'
2017-11-23 07:56:30,392 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-11-23 07:56:30,415 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-11-23 07:56:30,441 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-11-23 07:56:30,459 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-11-23 07:56:30,475 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-11-23 07:56:30,504 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-11-23 07:56:30,519 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-11-23 07:56:30,555 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-11-23 07:56:30,567 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-11-23 07:56:30,588 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-11-23 07:56:30,604 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-11-23 07:56:30,626 [salt.fileclient  ][INFO    ][24422] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-11-23 07:56:30,630 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-11-23 07:56:30,630 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-11-23 07:56:30,631 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-11-23 07:56:30,631 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-11-23 07:56:30,631 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-11-23 07:56:30,631 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-11-23 07:56:30,632 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-11-23 07:56:30,632 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-11-23 07:56:30,632 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-11-23 07:56:30,632 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-11-23 07:56:30,633 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-11-23 07:56:30,633 [salt.utils.extmods][INFO    ][24422] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-11-23 07:56:30,634 [salt.utils.extmods][INFO    ][24422] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-11-23 07:56:30,638 [salt.utils.extmods][INFO    ][24422] Syncing renderers for environment 'base'
2017-11-23 07:56:30,638 [salt.utils.extmods][INFO    ][24422] Loading cache from salt://_renderers, for base)
2017-11-23 07:56:30,638 [salt.fileclient  ][INFO    ][24422] Caching directory '_renderers/' for environment 'base'
2017-11-23 07:56:30,711 [salt.utils.extmods][INFO    ][24422] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-11-23 07:56:30,714 [salt.utils.extmods][INFO    ][24422] Syncing returners for environment 'base'
2017-11-23 07:56:30,715 [salt.utils.extmods][INFO    ][24422] Loading cache from salt://_returners, for base)
2017-11-23 07:56:30,715 [salt.fileclient  ][INFO    ][24422] Caching directory '_returners/' for environment 'base'
2017-11-23 07:56:30,758 [salt.utils.extmods][INFO    ][24422] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-11-23 07:56:30,761 [salt.utils.extmods][INFO    ][24422] Syncing output for environment 'base'
2017-11-23 07:56:30,761 [salt.utils.extmods][INFO    ][24422] Loading cache from salt://_output, for base)
2017-11-23 07:56:30,761 [salt.fileclient  ][INFO    ][24422] Caching directory '_output/' for environment 'base'
2017-11-23 07:56:30,809 [salt.utils.extmods][INFO    ][24422] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-11-23 07:56:30,812 [salt.utils.extmods][INFO    ][24422] Syncing utils for environment 'base'
2017-11-23 07:56:30,812 [salt.utils.extmods][INFO    ][24422] Loading cache from salt://_utils, for base)
2017-11-23 07:56:30,812 [salt.fileclient  ][INFO    ][24422] Caching directory '_utils/' for environment 'base'
2017-11-23 07:56:30,859 [salt.utils.extmods][INFO    ][24422] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-11-23 07:56:30,862 [salt.utils.extmods][INFO    ][24422] Syncing log_handlers for environment 'base'
2017-11-23 07:56:30,862 [salt.utils.extmods][INFO    ][24422] Loading cache from salt://_log_handlers, for base)
2017-11-23 07:56:30,862 [salt.fileclient  ][INFO    ][24422] Caching directory '_log_handlers/' for environment 'base'
2017-11-23 07:56:30,906 [salt.utils.extmods][INFO    ][24422] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-11-23 07:56:30,909 [salt.utils.extmods][INFO    ][24422] Syncing proxy for environment 'base'
2017-11-23 07:56:30,909 [salt.utils.extmods][INFO    ][24422] Loading cache from salt://_proxy, for base)
2017-11-23 07:56:30,909 [salt.fileclient  ][INFO    ][24422] Caching directory '_proxy/' for environment 'base'
2017-11-23 07:56:30,969 [salt.utils.extmods][INFO    ][24422] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-11-23 07:56:30,971 [salt.utils.extmods][INFO    ][24422] Syncing engines for environment 'base'
2017-11-23 07:56:30,972 [salt.utils.extmods][INFO    ][24422] Loading cache from salt://_engines, for base)
2017-11-23 07:56:30,972 [salt.fileclient  ][INFO    ][24422] Caching directory '_engines/' for environment 'base'
2017-11-23 07:56:31,030 [salt.minion      ][INFO    ][24422] Returning information for job: 20171123075623594649
2017-11-23 08:10:04,674 [salt.minion      ][INFO    ][24012] User sudo_ubuntu Executing command test.ping with jid 20171123081004685733
2017-11-23 08:10:04,689 [salt.minion      ][INFO    ][24681] Starting a new job with PID 24681
2017-11-23 08:10:04,728 [salt.minion      ][INFO    ][24681] Returning information for job: 20171123081004685733
2017-11-23 08:10:34,657 [salt.minion      ][INFO    ][24012] User sudo_ubuntu Executing command state.sls with jid 20171123081034670183
2017-11-23 08:10:34,668 [salt.minion      ][INFO    ][24690] Starting a new job with PID 24690
2017-11-23 08:10:35,242 [salt.state       ][INFO    ][24690] Loading fresh modules for state activity
2017-11-23 08:10:35,271 [salt.fileclient  ][INFO    ][24690] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-11-23 08:10:35,290 [salt.fileclient  ][INFO    ][24690] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-11-23 08:10:35,316 [salt.fileclient  ][INFO    ][24690] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-23 08:10:35,656 [salt.state       ][INFO    ][24690] Running state [lsof] at time 08:10:35.656318
2017-11-23 08:10:35,657 [salt.state       ][INFO    ][24690] Executing state pkg.installed for lsof
2017-11-23 08:10:35,657 [salt.loaded.int.module.cmdmod][INFO    ][24690] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-23 08:10:35,926 [salt.state       ][INFO    ][24690] Package lsof is already installed
2017-11-23 08:10:35,926 [salt.state       ][INFO    ][24690] Completed state [lsof] at time 08:10:35.925873 duration_in_ms=269.555
2017-11-23 08:10:35,926 [salt.state       ][INFO    ][24690] Running state [keepalived] at time 08:10:35.926133
2017-11-23 08:10:35,926 [salt.state       ][INFO    ][24690] Executing state pkg.installed for keepalived
2017-11-23 08:10:35,944 [salt.loaded.int.module.cmdmod][INFO    ][24690] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-11-23 08:10:37,352 [salt.loaded.int.module.cmdmod][INFO    ][24690] 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-23 08:10:39,978 [salt.loaded.int.module.cmdmod][INFO    ][24690] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-23 08:10:40,003 [salt.state       ][INFO    ][24690] 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-23 08:10:40,014 [salt.state       ][INFO    ][24690] Loading fresh modules for state activity
2017-11-23 08:10:40,031 [salt.state       ][INFO    ][24690] Completed state [keepalived] at time 08:10:40.030490 duration_in_ms=4104.356
2017-11-23 08:10:40,032 [salt.state       ][INFO    ][24690] Running state [/etc/keepalived/keepalived.conf] at time 08:10:40.032463
2017-11-23 08:10:40,033 [salt.state       ][INFO    ][24690] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-11-23 08:10:40,059 [salt.fileclient  ][INFO    ][24690] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-11-23 08:10:40,098 [salt.fileclient  ][INFO    ][24690] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-23 08:10:40,107 [salt.state       ][INFO    ][24690] File changed:
New file
2017-11-23 08:10:40,107 [salt.state       ][INFO    ][24690] Completed state [/etc/keepalived/keepalived.conf] at time 08:10:40.106771 duration_in_ms=74.308
2017-11-23 08:10:40,174 [salt.state       ][INFO    ][24690] Running state [keepalived] at time 08:10:40.173701
2017-11-23 08:10:40,174 [salt.state       ][INFO    ][24690] Executing state service.running for keepalived
2017-11-23 08:10:40,175 [salt.loaded.int.module.cmdmod][INFO    ][24690] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-11-23 08:10:40,185 [salt.loaded.int.module.cmdmod][INFO    ][24690] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-23 08:10:40,193 [salt.loaded.int.module.cmdmod][INFO    ][24690] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-23 08:10:40,200 [salt.loaded.int.module.cmdmod][INFO    ][24690] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-23 08:10:40,207 [salt.loaded.int.module.cmdmod][INFO    ][24690] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-11-23 08:10:40,238 [salt.loaded.int.module.cmdmod][INFO    ][24690] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-23 08:10:40,247 [salt.loaded.int.module.cmdmod][INFO    ][24690] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-23 08:10:40,255 [salt.loaded.int.module.cmdmod][INFO    ][24690] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-23 08:10:40,262 [salt.state       ][INFO    ][24690] {'keepalived': True}
2017-11-23 08:10:40,262 [salt.state       ][INFO    ][24690] Completed state [keepalived] at time 08:10:40.262274 duration_in_ms=88.572
2017-11-23 08:10:40,263 [salt.minion      ][INFO    ][24690] Returning information for job: 20171123081034670183
2017-11-23 08:12:07,524 [salt.minion      ][INFO    ][24012] User sudo_ubuntu Executing command pillar.get with jid 20171123081207538761
2017-11-23 08:12:07,537 [salt.minion      ][INFO    ][26295] Starting a new job with PID 26295
2017-11-23 08:12:07,541 [salt.minion      ][INFO    ][26295] Returning information for job: 20171123081207538761
2017-11-23 08:17:13,193 [salt.minion      ][INFO    ][24012] User sudo_ubuntu Executing command state.sls with jid 20171123081713206602
2017-11-23 08:17:13,205 [salt.minion      ][INFO    ][26388] Starting a new job with PID 26388
2017-11-23 08:17:15,486 [salt.state       ][INFO    ][26388] Loading fresh modules for state activity
2017-11-23 08:17:15,515 [salt.fileclient  ][INFO    ][26388] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-23 08:17:15,543 [salt.fileclient  ][INFO    ][26388] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-23 08:17:15,843 [salt.state       ][INFO    ][26388] Running state [attr] at time 08:17:15.842650
2017-11-23 08:17:15,843 [salt.state       ][INFO    ][26388] Executing state pkg.installed for attr
2017-11-23 08:17:15,843 [salt.loaded.int.module.cmdmod][INFO    ][26388] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-23 08:17:16,139 [salt.loaded.int.module.cmdmod][INFO    ][26388] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-11-23 08:17:17,618 [salt.loaded.int.module.cmdmod][INFO    ][26388] 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-23 08:17:18,929 [salt.loaded.int.module.cmdmod][INFO    ][26388] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-23 08:17:18,958 [salt.state       ][INFO    ][26388] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-11-23 08:17:18,969 [salt.state       ][INFO    ][26388] Loading fresh modules for state activity
2017-11-23 08:17:18,986 [salt.state       ][INFO    ][26388] Completed state [attr] at time 08:17:18.985556 duration_in_ms=3142.905
2017-11-23 08:17:18,991 [salt.state       ][INFO    ][26388] Running state [glusterfs-server] at time 08:17:18.991293
2017-11-23 08:17:18,991 [salt.state       ][INFO    ][26388] Executing state pkg.installed for glusterfs-server
2017-11-23 08:17:19,224 [salt.loaded.int.module.cmdmod][INFO    ][26388] 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-23 08:17:23,293 [salt.minion      ][INFO    ][24012] User sudo_ubuntu Executing command saltutil.find_job with jid 20171123081723304957
2017-11-23 08:17:23,304 [salt.minion      ][INFO    ][30281] Starting a new job with PID 30281
2017-11-23 08:17:23,317 [salt.minion      ][INFO    ][30281] Returning information for job: 20171123081723304957
2017-11-23 08:17:25,271 [salt.loaded.int.module.cmdmod][INFO    ][26388] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-23 08:17:25,299 [salt.state       ][INFO    ][26388] Made the following changes:
'keyutils' changed from 'absent' to '1.5.9-8ubuntu1'
'nfs-common' changed from 'absent' to '1:1.2.8-9ubuntu12.1'
'rpcbind' changed from 'absent' to '0.2.3-0.2'
'glusterfs-common' changed from 'absent' to '3.7.6-1ubuntu1'
'librdmacm1' changed from 'absent' to '1.0.21-1'
'libnfsidmap2' changed from 'absent' to '0.25-5'
'portmap' changed from 'absent' to '1'
'libattr1-dev' changed from 'absent' to '1:2.4.47-2'
'attr-dev' changed from 'absent' to '1'
'acl-dev' changed from 'absent' to '1'
'glusterfs-server' changed from 'absent' to '3.7.6-1ubuntu1'
'glusterfs-client' changed from 'absent' to '3.7.6-1ubuntu1'
'libpython2.7' changed from 'absent' to '2.7.12-1ubuntu0~16.04.1'
'nfs-client' changed from 'absent' to '1'
'liburcu4' changed from 'absent' to '0.9.1-3'
'libacl1-dev' changed from 'absent' to '2.2.52-3'
'libibverbs1' changed from 'absent' to '1.1.8-1.1ubuntu2'
'libtirpc1' changed from 'absent' to '0.2.5-1'

2017-11-23 08:17:25,308 [salt.state       ][INFO    ][26388] Loading fresh modules for state activity
2017-11-23 08:17:25,325 [salt.state       ][INFO    ][26388] Completed state [glusterfs-server] at time 08:17:25.325176 duration_in_ms=6333.883
2017-11-23 08:17:25,331 [salt.state       ][INFO    ][26388] Running state [bc] at time 08:17:25.330628
2017-11-23 08:17:25,331 [salt.state       ][INFO    ][26388] Executing state pkg.installed for bc
2017-11-23 08:17:25,608 [salt.loaded.int.module.cmdmod][INFO    ][26388] 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-23 08:17:27,010 [salt.loaded.int.module.cmdmod][INFO    ][26388] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-23 08:17:27,036 [salt.state       ][INFO    ][26388] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-11-23 08:17:27,046 [salt.state       ][INFO    ][26388] Loading fresh modules for state activity
2017-11-23 08:17:27,063 [salt.state       ][INFO    ][26388] Completed state [bc] at time 08:17:27.062958 duration_in_ms=1732.329
2017-11-23 08:17:27,134 [salt.state       ][INFO    ][26388] Running state [glusterfs-server] at time 08:17:27.133749
2017-11-23 08:17:27,134 [salt.state       ][INFO    ][26388] Executing state service.running for glusterfs-server
2017-11-23 08:17:27,136 [salt.loaded.int.module.cmdmod][INFO    ][26388] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-23 08:17:27,145 [salt.loaded.int.module.cmdmod][INFO    ][26388] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-23 08:17:27,152 [salt.loaded.int.module.cmdmod][INFO    ][26388] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-23 08:17:27,160 [salt.state       ][INFO    ][26388] The service glusterfs-server is already running
2017-11-23 08:17:27,160 [salt.state       ][INFO    ][26388] Completed state [glusterfs-server] at time 08:17:27.160427 duration_in_ms=26.679
2017-11-23 08:17:27,162 [salt.state       ][INFO    ][26388] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 08:17:27.161868
2017-11-23 08:17:27,162 [salt.state       ][INFO    ][26388] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-23 08:17:27,167 [salt.state       ][INFO    ][26388] File changed:
New file
2017-11-23 08:17:27,167 [salt.state       ][INFO    ][26388] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 08:17:27.166921 duration_in_ms=5.052
2017-11-23 08:17:27,167 [salt.state       ][INFO    ][26388] Running state [/srv/glusterfs/glance] at time 08:17:27.167129
2017-11-23 08:17:27,167 [salt.state       ][INFO    ][26388] Executing state file.directory for /srv/glusterfs/glance
2017-11-23 08:17:27,168 [salt.state       ][INFO    ][26388] {'/srv/glusterfs/glance': 'New Dir'}
2017-11-23 08:17:27,168 [salt.state       ][INFO    ][26388] Completed state [/srv/glusterfs/glance] at time 08:17:27.168180 duration_in_ms=1.051
2017-11-23 08:17:27,168 [salt.state       ][INFO    ][26388] Running state [/srv/glusterfs/keystone-keys] at time 08:17:27.168363
2017-11-23 08:17:27,169 [salt.state       ][INFO    ][26388] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-23 08:17:27,169 [salt.state       ][INFO    ][26388] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-11-23 08:17:27,169 [salt.state       ][INFO    ][26388] Completed state [/srv/glusterfs/keystone-keys] at time 08:17:27.169204 duration_in_ms=0.841
2017-11-23 08:17:27,169 [salt.state       ][INFO    ][26388] Running state [/srv/glusterfs/nova_instances] at time 08:17:27.169408
2017-11-23 08:17:27,170 [salt.state       ][INFO    ][26388] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-23 08:17:27,170 [salt.state       ][INFO    ][26388] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-11-23 08:17:27,170 [salt.state       ][INFO    ][26388] Completed state [/srv/glusterfs/nova_instances] at time 08:17:27.170215 duration_in_ms=0.807
2017-11-23 08:17:27,170 [salt.state       ][INFO    ][26388] Running state [/srv/glusterfs/keystone-credential-keys] at time 08:17:27.170392
2017-11-23 08:17:27,171 [salt.state       ][INFO    ][26388] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-23 08:17:27,171 [salt.state       ][INFO    ][26388] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-11-23 08:17:27,171 [salt.state       ][INFO    ][26388] Completed state [/srv/glusterfs/keystone-credential-keys] at time 08:17:27.171206 duration_in_ms=0.814
2017-11-23 08:17:27,172 [salt.minion      ][INFO    ][26388] Returning information for job: 20171123081713206602
2017-11-23 08:17:29,102 [salt.minion      ][INFO    ][24012] User sudo_ubuntu Executing command test.ping with jid 20171123081729117029
2017-11-23 08:17:29,114 [salt.minion      ][INFO    ][31117] Starting a new job with PID 31117
2017-11-23 08:17:29,150 [salt.minion      ][INFO    ][31117] Returning information for job: 20171123081729117029
2017-11-23 08:17:57,242 [salt.minion      ][INFO    ][24012] User sudo_ubuntu Executing command state.sls with jid 20171123081757254190
2017-11-23 08:17:57,254 [salt.minion      ][INFO    ][31328] Starting a new job with PID 31328
2017-11-23 08:17:57,860 [salt.state       ][INFO    ][31328] Loading fresh modules for state activity
2017-11-23 08:17:57,895 [salt.fileclient  ][INFO    ][31328] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-11-23 08:17:57,944 [salt.fileclient  ][INFO    ][31328] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-23 08:17:58,032 [salt.fileclient  ][INFO    ][31328] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-23 08:17:58,059 [salt.fileclient  ][INFO    ][31328] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-23 08:17:58,366 [salt.state       ][INFO    ][31328] Running state [attr] at time 08:17:58.365966
2017-11-23 08:17:58,366 [salt.state       ][INFO    ][31328] Executing state pkg.installed for attr
2017-11-23 08:17:58,367 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-23 08:17:58,623 [salt.state       ][INFO    ][31328] Package attr is already installed
2017-11-23 08:17:58,623 [salt.state       ][INFO    ][31328] Completed state [attr] at time 08:17:58.623302 duration_in_ms=257.336
2017-11-23 08:17:58,624 [salt.state       ][INFO    ][31328] Running state [glusterfs-server] at time 08:17:58.623547
2017-11-23 08:17:58,624 [salt.state       ][INFO    ][31328] Executing state pkg.installed for glusterfs-server
2017-11-23 08:17:58,627 [salt.state       ][INFO    ][31328] Package glusterfs-server is already installed
2017-11-23 08:17:58,628 [salt.state       ][INFO    ][31328] Completed state [glusterfs-server] at time 08:17:58.627516 duration_in_ms=3.969
2017-11-23 08:17:58,628 [salt.state       ][INFO    ][31328] Running state [bc] at time 08:17:58.627723
2017-11-23 08:17:58,628 [salt.state       ][INFO    ][31328] Executing state pkg.installed for bc
2017-11-23 08:17:58,632 [salt.state       ][INFO    ][31328] Package bc is already installed
2017-11-23 08:17:58,632 [salt.state       ][INFO    ][31328] Completed state [bc] at time 08:17:58.631769 duration_in_ms=4.045
2017-11-23 08:17:58,633 [salt.state       ][INFO    ][31328] Running state [glusterfs-server] at time 08:17:58.632769
2017-11-23 08:17:58,633 [salt.state       ][INFO    ][31328] Executing state service.running for glusterfs-server
2017-11-23 08:17:58,633 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-23 08:17:58,643 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-11-23 08:17:58,691 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-23 08:17:58,705 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-23 08:17:58,712 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-23 08:17:58,720 [salt.state       ][INFO    ][31328] The service glusterfs-server is already running
2017-11-23 08:17:58,720 [salt.state       ][INFO    ][31328] Completed state [glusterfs-server] at time 08:17:58.720025 duration_in_ms=87.256
2017-11-23 08:17:58,722 [salt.state       ][INFO    ][31328] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 08:17:58.721576
2017-11-23 08:17:58,722 [salt.state       ][INFO    ][31328] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-23 08:17:58,724 [salt.state       ][INFO    ][31328] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-23 08:17:58,724 [salt.state       ][INFO    ][31328] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 08:17:58.723885 duration_in_ms=2.309
2017-11-23 08:17:58,724 [salt.state       ][INFO    ][31328] Running state [/srv/glusterfs/glance] at time 08:17:58.724111
2017-11-23 08:17:58,724 [salt.state       ][INFO    ][31328] Executing state file.directory for /srv/glusterfs/glance
2017-11-23 08:17:58,725 [salt.state       ][INFO    ][31328] Directory /srv/glusterfs/glance is in the correct state
2017-11-23 08:17:58,725 [salt.state       ][INFO    ][31328] Completed state [/srv/glusterfs/glance] at time 08:17:58.724903 duration_in_ms=0.792
2017-11-23 08:17:58,725 [salt.state       ][INFO    ][31328] Running state [/srv/glusterfs/keystone-keys] at time 08:17:58.725130
2017-11-23 08:17:58,725 [salt.state       ][INFO    ][31328] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-23 08:17:58,726 [salt.state       ][INFO    ][31328] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-23 08:17:58,726 [salt.state       ][INFO    ][31328] Completed state [/srv/glusterfs/keystone-keys] at time 08:17:58.725897 duration_in_ms=0.767
2017-11-23 08:17:58,726 [salt.state       ][INFO    ][31328] Running state [/srv/glusterfs/nova_instances] at time 08:17:58.726089
2017-11-23 08:17:58,726 [salt.state       ][INFO    ][31328] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-23 08:17:58,727 [salt.state       ][INFO    ][31328] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-23 08:17:58,727 [salt.state       ][INFO    ][31328] Completed state [/srv/glusterfs/nova_instances] at time 08:17:58.726831 duration_in_ms=0.73
2017-11-23 08:17:58,727 [salt.state       ][INFO    ][31328] Running state [/srv/glusterfs/keystone-credential-keys] at time 08:17:58.727006
2017-11-23 08:17:58,727 [salt.state       ][INFO    ][31328] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-23 08:17:58,728 [salt.state       ][INFO    ][31328] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-23 08:17:58,728 [salt.state       ][INFO    ][31328] Completed state [/srv/glusterfs/keystone-credential-keys] at time 08:17:58.727697 duration_in_ms=0.691
2017-11-23 08:17:58,792 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command ['git', '--version'] in directory '/root'
2017-11-23 08:17:58,876 [salt.state       ][INFO    ][31328] Running state [sleep 5] at time 08:17:58.876315
2017-11-23 08:17:58,877 [salt.state       ][INFO    ][31328] Executing state cmd.wait for sleep 5
2017-11-23 08:17:58,877 [salt.state       ][INFO    ][31328] No changes made for sleep 5
2017-11-23 08:17:58,877 [salt.state       ][INFO    ][31328] Completed state [sleep 5] at time 08:17:58.877059 duration_in_ms=0.744
2017-11-23 08:17:58,878 [salt.state       ][INFO    ][31328] Running state [192.168.10.143] at time 08:17:58.877620
2017-11-23 08:17:58,878 [salt.state       ][INFO    ][31328] Executing state glusterfs.peered for 192.168.10.143
2017-11-23 08:17:58,878 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:58,887 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:58,938 [salt.state       ][INFO    ][31328] Host 192.168.10.143 already peered
2017-11-23 08:17:58,939 [salt.state       ][INFO    ][31328] Completed state [192.168.10.143] at time 08:17:58.938549 duration_in_ms=60.928
2017-11-23 08:17:58,942 [salt.state       ][INFO    ][31328] Running state [192.168.10.142] at time 08:17:58.941547
2017-11-23 08:17:58,942 [salt.state       ][INFO    ][31328] Executing state glusterfs.peered for 192.168.10.142
2017-11-23 08:17:58,942 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:58,951 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:59,002 [salt.state       ][INFO    ][31328] Host 192.168.10.142 already peered
2017-11-23 08:17:59,003 [salt.state       ][INFO    ][31328] Completed state [192.168.10.142] at time 08:17:59.002618 duration_in_ms=61.07
2017-11-23 08:17:59,006 [salt.state       ][INFO    ][31328] Running state [192.168.10.141] at time 08:17:59.005537
2017-11-23 08:17:59,006 [salt.state       ][INFO    ][31328] Executing state glusterfs.peered for 192.168.10.141
2017-11-23 08:17:59,006 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:59,013 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:59,064 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:59,072 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:59,123 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:59,130 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:59,181 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:59,187 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:59,239 [salt.state       ][INFO    ][31328] Peering with localhost is not needed
2017-11-23 08:17:59,239 [salt.state       ][INFO    ][31328] Completed state [192.168.10.141] at time 08:17:59.239033 duration_in_ms=233.496
2017-11-23 08:17:59,240 [salt.state       ][INFO    ][31328] Running state [glance] at time 08:17:59.240071
2017-11-23 08:17:59,240 [salt.state       ][INFO    ][31328] Executing state glusterfs.created for glance
2017-11-23 08:17:59,241 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:59,249 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:59,299 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:59,306 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:59,360 [salt.state       ][INFO    ][31328] Volume glance already exists and is started.
2017-11-23 08:17:59,360 [salt.state       ][INFO    ][31328] Completed state [glance] at time 08:17:59.360097 duration_in_ms=120.024
2017-11-23 08:17:59,364 [salt.state       ][INFO    ][31328] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 08:17:59.363606
2017-11-23 08:17:59,364 [salt.state       ][INFO    ][31328] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-11-23 08:17:59,364 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-23 08:17:59,416 [salt.state       ][INFO    ][31328] unless execution succeeded
2017-11-23 08:17:59,416 [salt.state       ][INFO    ][31328] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 08:17:59.416371 duration_in_ms=52.765
2017-11-23 08:17:59,417 [salt.state       ][INFO    ][31328] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 08:17:59.416919
2017-11-23 08:17:59,417 [salt.state       ][INFO    ][31328] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-11-23 08:17:59,418 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-23 08:17:59,468 [salt.state       ][INFO    ][31328] unless execution succeeded
2017-11-23 08:17:59,469 [salt.state       ][INFO    ][31328] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 08:17:59.468461 duration_in_ms=51.542
2017-11-23 08:17:59,469 [salt.state       ][INFO    ][31328] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 08:17:59.469021
2017-11-23 08:17:59,469 [salt.state       ][INFO    ][31328] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-11-23 08:17:59,470 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-11-23 08:17:59,518 [salt.state       ][INFO    ][31328] unless execution succeeded
2017-11-23 08:17:59,518 [salt.state       ][INFO    ][31328] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 08:17:59.518182 duration_in_ms=49.161
2017-11-23 08:17:59,519 [salt.state       ][INFO    ][31328] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 08:17:59.518633
2017-11-23 08:17:59,519 [salt.state       ][INFO    ][31328] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-11-23 08:17:59,519 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-23 08:17:59,571 [salt.state       ][INFO    ][31328] unless execution succeeded
2017-11-23 08:17:59,571 [salt.state       ][INFO    ][31328] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 08:17:59.571204 duration_in_ms=52.571
2017-11-23 08:17:59,572 [salt.state       ][INFO    ][31328] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 08:17:59.571825
2017-11-23 08:17:59,572 [salt.state       ][INFO    ][31328] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-11-23 08:17:59,573 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-23 08:17:59,623 [salt.state       ][INFO    ][31328] unless execution succeeded
2017-11-23 08:17:59,624 [salt.state       ][INFO    ][31328] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 08:17:59.623674 duration_in_ms=51.848
2017-11-23 08:17:59,625 [salt.state       ][INFO    ][31328] Running state [glance] at time 08:17:59.624911
2017-11-23 08:17:59,625 [salt.state       ][INFO    ][31328] Executing state glusterfs.started for glance
2017-11-23 08:17:59,626 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:59,632 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:59,680 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:59,686 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:59,742 [salt.state       ][INFO    ][31328] Volume glance is already started
2017-11-23 08:17:59,742 [salt.state       ][INFO    ][31328] Completed state [glance] at time 08:17:59.741987 duration_in_ms=117.076
2017-11-23 08:17:59,743 [salt.state       ][INFO    ][31328] Running state [keystone-keys] at time 08:17:59.742993
2017-11-23 08:17:59,743 [salt.state       ][INFO    ][31328] Executing state glusterfs.created for keystone-keys
2017-11-23 08:17:59,744 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:59,751 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:59,804 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:59,812 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:59,867 [salt.state       ][INFO    ][31328] Volume keystone-keys already exists and is started.
2017-11-23 08:17:59,867 [salt.state       ][INFO    ][31328] Completed state [keystone-keys] at time 08:17:59.866824 duration_in_ms=123.831
2017-11-23 08:17:59,871 [salt.state       ][INFO    ][31328] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 08:17:59.870779
2017-11-23 08:17:59,871 [salt.state       ][INFO    ][31328] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-11-23 08:17:59,872 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-23 08:17:59,922 [salt.state       ][INFO    ][31328] unless execution succeeded
2017-11-23 08:17:59,922 [salt.state       ][INFO    ][31328] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 08:17:59.921817 duration_in_ms=51.038
2017-11-23 08:17:59,922 [salt.state       ][INFO    ][31328] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 08:17:59.922348
2017-11-23 08:17:59,923 [salt.state       ][INFO    ][31328] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-23 08:17:59,923 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-23 08:17:59,975 [salt.state       ][INFO    ][31328] unless execution succeeded
2017-11-23 08:17:59,975 [salt.state       ][INFO    ][31328] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 08:17:59.975381 duration_in_ms=53.033
2017-11-23 08:17:59,976 [salt.state       ][INFO    ][31328] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 08:17:59.976009
2017-11-23 08:17:59,976 [salt.state       ][INFO    ][31328] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-23 08:17:59,977 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-23 08:18:00,028 [salt.state       ][INFO    ][31328] unless execution succeeded
2017-11-23 08:18:00,028 [salt.state       ][INFO    ][31328] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 08:18:00.027969 duration_in_ms=51.959
2017-11-23 08:18:00,029 [salt.state       ][INFO    ][31328] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 08:18:00.028505
2017-11-23 08:18:00,029 [salt.state       ][INFO    ][31328] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-11-23 08:18:00,029 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-23 08:18:00,083 [salt.state       ][INFO    ][31328] unless execution succeeded
2017-11-23 08:18:00,083 [salt.state       ][INFO    ][31328] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 08:18:00.082754 duration_in_ms=54.248
2017-11-23 08:18:00,083 [salt.state       ][INFO    ][31328] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 08:18:00.083373
2017-11-23 08:18:00,084 [salt.state       ][INFO    ][31328] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-11-23 08:18:00,084 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-23 08:18:00,137 [salt.state       ][INFO    ][31328] unless execution succeeded
2017-11-23 08:18:00,138 [salt.state       ][INFO    ][31328] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 08:18:00.137830 duration_in_ms=54.457
2017-11-23 08:18:00,140 [salt.state       ][INFO    ][31328] Running state [keystone-keys] at time 08:18:00.139480
2017-11-23 08:18:00,140 [salt.state       ][INFO    ][31328] Executing state glusterfs.started for keystone-keys
2017-11-23 08:18:00,141 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:18:00,150 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:18:00,200 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:18:00,207 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:18:00,262 [salt.state       ][INFO    ][31328] Volume keystone-keys is already started
2017-11-23 08:18:00,262 [salt.state       ][INFO    ][31328] Completed state [keystone-keys] at time 08:18:00.262287 duration_in_ms=122.806
2017-11-23 08:18:00,264 [salt.state       ][INFO    ][31328] Running state [nova_instances] at time 08:18:00.263779
2017-11-23 08:18:00,264 [salt.state       ][INFO    ][31328] Executing state glusterfs.created for nova_instances
2017-11-23 08:18:00,265 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:18:00,272 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:18:00,323 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:18:00,331 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:18:00,387 [salt.state       ][INFO    ][31328] Volume nova_instances already exists and is started.
2017-11-23 08:18:00,387 [salt.state       ][INFO    ][31328] Completed state [nova_instances] at time 08:18:00.386966 duration_in_ms=123.186
2017-11-23 08:18:00,391 [salt.state       ][INFO    ][31328] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 08:18:00.391053
2017-11-23 08:18:00,391 [salt.state       ][INFO    ][31328] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-11-23 08:18:00,392 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-23 08:18:00,443 [salt.state       ][INFO    ][31328] unless execution succeeded
2017-11-23 08:18:00,443 [salt.state       ][INFO    ][31328] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 08:18:00.442930 duration_in_ms=51.877
2017-11-23 08:18:00,444 [salt.state       ][INFO    ][31328] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 08:18:00.443553
2017-11-23 08:18:00,444 [salt.state       ][INFO    ][31328] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-11-23 08:18:00,444 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-11-23 08:18:00,494 [salt.state       ][INFO    ][31328] unless execution succeeded
2017-11-23 08:18:00,494 [salt.state       ][INFO    ][31328] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 08:18:00.493804 duration_in_ms=50.251
2017-11-23 08:18:00,494 [salt.state       ][INFO    ][31328] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 08:18:00.494372
2017-11-23 08:18:00,495 [salt.state       ][INFO    ][31328] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-11-23 08:18:00,495 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-11-23 08:18:00,546 [salt.state       ][INFO    ][31328] unless execution succeeded
2017-11-23 08:18:00,546 [salt.state       ][INFO    ][31328] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 08:18:00.546041 duration_in_ms=51.669
2017-11-23 08:18:00,547 [salt.state       ][INFO    ][31328] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 08:18:00.546618
2017-11-23 08:18:00,547 [salt.state       ][INFO    ][31328] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-11-23 08:18:00,547 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-11-23 08:18:00,596 [salt.state       ][INFO    ][31328] unless execution succeeded
2017-11-23 08:18:00,596 [salt.state       ][INFO    ][31328] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 08:18:00.596154 duration_in_ms=49.535
2017-11-23 08:18:00,597 [salt.state       ][INFO    ][31328] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 08:18:00.596695
2017-11-23 08:18:00,597 [salt.state       ][INFO    ][31328] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-11-23 08:18:00,597 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-23 08:18:00,649 [salt.state       ][INFO    ][31328] unless execution succeeded
2017-11-23 08:18:00,649 [salt.state       ][INFO    ][31328] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 08:18:00.648788 duration_in_ms=52.092
2017-11-23 08:18:00,650 [salt.state       ][INFO    ][31328] Running state [nova_instances] at time 08:18:00.650160
2017-11-23 08:18:00,650 [salt.state       ][INFO    ][31328] Executing state glusterfs.started for nova_instances
2017-11-23 08:18:00,651 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:18:00,658 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:18:00,709 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:18:00,717 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:18:00,771 [salt.state       ][INFO    ][31328] Volume nova_instances is already started
2017-11-23 08:18:00,771 [salt.state       ][INFO    ][31328] Completed state [nova_instances] at time 08:18:00.770983 duration_in_ms=120.823
2017-11-23 08:18:00,772 [salt.state       ][INFO    ][31328] Running state [keystone-credential-keys] at time 08:18:00.772218
2017-11-23 08:18:00,773 [salt.state       ][INFO    ][31328] Executing state glusterfs.created for keystone-credential-keys
2017-11-23 08:18:00,773 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:18:00,781 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:18:00,833 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:18:00,839 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:18:00,895 [salt.state       ][INFO    ][31328] Volume keystone-credential-keys already exists and is started.
2017-11-23 08:18:00,895 [salt.state       ][INFO    ][31328] Completed state [keystone-credential-keys] at time 08:18:00.895155 duration_in_ms=122.937
2017-11-23 08:18:00,899 [salt.state       ][INFO    ][31328] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 08:18:00.899190
2017-11-23 08:18:00,899 [salt.state       ][INFO    ][31328] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-11-23 08:18:00,900 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-23 08:18:00,950 [salt.state       ][INFO    ][31328] unless execution succeeded
2017-11-23 08:18:00,951 [salt.state       ][INFO    ][31328] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 08:18:00.950744 duration_in_ms=51.553
2017-11-23 08:18:00,951 [salt.state       ][INFO    ][31328] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 08:18:00.951390
2017-11-23 08:18:00,952 [salt.state       ][INFO    ][31328] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-23 08:18:00,952 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-23 08:18:01,003 [salt.state       ][INFO    ][31328] unless execution succeeded
2017-11-23 08:18:01,003 [salt.state       ][INFO    ][31328] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 08:18:01.003415 duration_in_ms=52.025
2017-11-23 08:18:01,004 [salt.state       ][INFO    ][31328] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 08:18:01.003975
2017-11-23 08:18:01,004 [salt.state       ][INFO    ][31328] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-11-23 08:18:01,005 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-23 08:18:01,057 [salt.state       ][INFO    ][31328] unless execution succeeded
2017-11-23 08:18:01,058 [salt.state       ][INFO    ][31328] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 08:18:01.057574 duration_in_ms=53.599
2017-11-23 08:18:01,058 [salt.state       ][INFO    ][31328] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 08:18:01.058291
2017-11-23 08:18:01,059 [salt.state       ][INFO    ][31328] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-23 08:18:01,059 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-23 08:18:01,112 [salt.state       ][INFO    ][31328] unless execution succeeded
2017-11-23 08:18:01,112 [salt.state       ][INFO    ][31328] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 08:18:01.112326 duration_in_ms=54.035
2017-11-23 08:18:01,113 [salt.state       ][INFO    ][31328] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 08:18:01.112930
2017-11-23 08:18:01,113 [salt.state       ][INFO    ][31328] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-11-23 08:18:01,114 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-23 08:18:01,164 [salt.state       ][INFO    ][31328] unless execution succeeded
2017-11-23 08:18:01,165 [salt.state       ][INFO    ][31328] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 08:18:01.164642 duration_in_ms=51.712
2017-11-23 08:18:01,166 [salt.state       ][INFO    ][31328] Running state [keystone-credential-keys] at time 08:18:01.165913
2017-11-23 08:18:01,166 [salt.state       ][INFO    ][31328] Executing state glusterfs.started for keystone-credential-keys
2017-11-23 08:18:01,167 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:18:01,173 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:18:01,225 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:18:01,232 [salt.loaded.int.module.cmdmod][INFO    ][31328] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:18:01,286 [salt.state       ][INFO    ][31328] Volume keystone-credential-keys is already started
2017-11-23 08:18:01,287 [salt.state       ][INFO    ][31328] Completed state [keystone-credential-keys] at time 08:18:01.286741 duration_in_ms=120.817
2017-11-23 08:18:01,290 [salt.minion      ][INFO    ][31328] Returning information for job: 20171123081757254190
2017-11-23 08:18:02,384 [salt.minion      ][INFO    ][24012] User sudo_ubuntu Executing command test.ping with jid 20171123081802399861
2017-11-23 08:18:02,395 [salt.minion      ][INFO    ][31728] Starting a new job with PID 31728
2017-11-23 08:18:02,431 [salt.minion      ][INFO    ][31728] Returning information for job: 20171123081802399861
2017-11-23 08:18:03,085 [salt.minion      ][INFO    ][24012] User sudo_ubuntu Executing command cmd.run with jid 20171123081803098079
2017-11-23 08:18:03,096 [salt.minion      ][INFO    ][31734] Starting a new job with PID 31734
2017-11-23 08:18:03,100 [salt.loaded.int.module.cmdmod][INFO    ][31734] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-11-23 08:18:03,212 [salt.minion      ][INFO    ][31734] Returning information for job: 20171123081803098079
2017-11-23 08:55:18,963 [salt.utils.schedule][INFO    ][24012] Running scheduled job: __mine_interval
2017-11-23 08:57:37,046 [salt.minion      ][INFO    ][24012] User sudo_ubuntu Executing command test.ping with jid 20171123085737056710
2017-11-23 08:57:37,062 [salt.minion      ][INFO    ][32308] Starting a new job with PID 32308
2017-11-23 08:57:37,102 [salt.minion      ][INFO    ][32308] Returning information for job: 20171123085737056710
2017-11-23 08:57:45,150 [salt.minion      ][INFO    ][24012] User sudo_ubuntu Executing command state.sls with jid 20171123085745156187
2017-11-23 08:57:45,160 [salt.minion      ][INFO    ][32314] Starting a new job with PID 32314
2017-11-23 08:57:45,740 [salt.state       ][INFO    ][32314] Loading fresh modules for state activity
2017-11-23 08:57:45,774 [salt.fileclient  ][INFO    ][32314] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-11-23 08:57:45,795 [salt.fileclient  ][INFO    ][32314] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-11-23 08:57:45,825 [salt.fileclient  ][INFO    ][32314] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-23 08:57:46,117 [salt.state       ][INFO    ][32314] Running state [lsof] at time 08:57:46.116784
2017-11-23 08:57:46,117 [salt.state       ][INFO    ][32314] Executing state pkg.installed for lsof
2017-11-23 08:57:46,117 [salt.loaded.int.module.cmdmod][INFO    ][32314] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-23 08:57:46,379 [salt.state       ][INFO    ][32314] Package lsof is already installed
2017-11-23 08:57:46,379 [salt.state       ][INFO    ][32314] Completed state [lsof] at time 08:57:46.379390 duration_in_ms=262.607
2017-11-23 08:57:46,380 [salt.state       ][INFO    ][32314] Running state [keepalived] at time 08:57:46.379623
2017-11-23 08:57:46,380 [salt.state       ][INFO    ][32314] Executing state pkg.installed for keepalived
2017-11-23 08:57:46,383 [salt.state       ][INFO    ][32314] Package keepalived is already installed
2017-11-23 08:57:46,384 [salt.state       ][INFO    ][32314] Completed state [keepalived] at time 08:57:46.383611 duration_in_ms=3.989
2017-11-23 08:57:46,385 [salt.state       ][INFO    ][32314] Running state [/etc/keepalived/keepalived.conf] at time 08:57:46.385070
2017-11-23 08:57:46,385 [salt.state       ][INFO    ][32314] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-11-23 08:57:46,414 [salt.fileclient  ][INFO    ][32314] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-11-23 08:57:46,456 [salt.fileclient  ][INFO    ][32314] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-23 08:57:46,461 [salt.state       ][INFO    ][32314] File /etc/keepalived/keepalived.conf is in the correct state
2017-11-23 08:57:46,461 [salt.state       ][INFO    ][32314] Completed state [/etc/keepalived/keepalived.conf] at time 08:57:46.461143 duration_in_ms=76.073
2017-11-23 08:57:46,462 [salt.state       ][INFO    ][32314] Running state [keepalived] at time 08:57:46.461728
2017-11-23 08:57:46,462 [salt.state       ][INFO    ][32314] Executing state service.running for keepalived
2017-11-23 08:57:46,462 [salt.loaded.int.module.cmdmod][INFO    ][32314] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-11-23 08:57:46,475 [salt.loaded.int.module.cmdmod][INFO    ][32314] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-23 08:57:46,480 [salt.loaded.int.module.cmdmod][INFO    ][32314] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-23 08:57:46,488 [salt.state       ][INFO    ][32314] The service keepalived is already running
2017-11-23 08:57:46,488 [salt.state       ][INFO    ][32314] Completed state [keepalived] at time 08:57:46.487899 duration_in_ms=26.171
2017-11-23 08:57:46,489 [salt.minion      ][INFO    ][32314] Returning information for job: 20171123085745156187
2017-11-23 08:58:13,771 [salt.minion      ][INFO    ][24012] User sudo_ubuntu Executing command pillar.get with jid 20171123085813782368
2017-11-23 08:58:13,785 [salt.minion      ][INFO    ][32340] Starting a new job with PID 32340
2017-11-23 08:58:13,788 [salt.minion      ][INFO    ][32340] Returning information for job: 20171123085813782368
2017-11-23 08:58:57,248 [salt.minion      ][INFO    ][24012] User sudo_ubuntu Executing command state.sls with jid 20171123085857256282
2017-11-23 08:58:57,259 [salt.minion      ][INFO    ][32353] Starting a new job with PID 32353
2017-11-23 08:58:59,543 [salt.state       ][INFO    ][32353] Loading fresh modules for state activity
2017-11-23 08:58:59,568 [salt.fileclient  ][INFO    ][32353] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-23 08:58:59,589 [salt.fileclient  ][INFO    ][32353] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-23 08:58:59,903 [salt.state       ][INFO    ][32353] Running state [attr] at time 08:58:59.903036
2017-11-23 08:58:59,903 [salt.state       ][INFO    ][32353] Executing state pkg.installed for attr
2017-11-23 08:58:59,904 [salt.loaded.int.module.cmdmod][INFO    ][32353] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-23 08:59:00,181 [salt.state       ][INFO    ][32353] Package attr is already installed
2017-11-23 08:59:00,182 [salt.state       ][INFO    ][32353] Completed state [attr] at time 08:59:00.181675 duration_in_ms=278.639
2017-11-23 08:59:00,182 [salt.state       ][INFO    ][32353] Running state [glusterfs-server] at time 08:59:00.181981
2017-11-23 08:59:00,182 [salt.state       ][INFO    ][32353] Executing state pkg.installed for glusterfs-server
2017-11-23 08:59:00,186 [salt.state       ][INFO    ][32353] Package glusterfs-server is already installed
2017-11-23 08:59:00,186 [salt.state       ][INFO    ][32353] Completed state [glusterfs-server] at time 08:59:00.186238 duration_in_ms=4.257
2017-11-23 08:59:00,186 [salt.state       ][INFO    ][32353] Running state [bc] at time 08:59:00.186449
2017-11-23 08:59:00,187 [salt.state       ][INFO    ][32353] Executing state pkg.installed for bc
2017-11-23 08:59:00,190 [salt.state       ][INFO    ][32353] Package bc is already installed
2017-11-23 08:59:00,191 [salt.state       ][INFO    ][32353] Completed state [bc] at time 08:59:00.190564 duration_in_ms=4.115
2017-11-23 08:59:00,191 [salt.state       ][INFO    ][32353] Running state [glusterfs-server] at time 08:59:00.191391
2017-11-23 08:59:00,192 [salt.state       ][INFO    ][32353] Executing state service.running for glusterfs-server
2017-11-23 08:59:00,192 [salt.loaded.int.module.cmdmod][INFO    ][32353] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-23 08:59:00,207 [salt.loaded.int.module.cmdmod][INFO    ][32353] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-23 08:59:00,215 [salt.loaded.int.module.cmdmod][INFO    ][32353] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-23 08:59:00,224 [salt.state       ][INFO    ][32353] The service glusterfs-server is already running
2017-11-23 08:59:00,224 [salt.state       ][INFO    ][32353] Completed state [glusterfs-server] at time 08:59:00.224401 duration_in_ms=33.01
2017-11-23 08:59:00,226 [salt.state       ][INFO    ][32353] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 08:59:00.226000
2017-11-23 08:59:00,226 [salt.state       ][INFO    ][32353] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-23 08:59:00,228 [salt.state       ][INFO    ][32353] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-23 08:59:00,228 [salt.state       ][INFO    ][32353] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 08:59:00.228329 duration_in_ms=2.329
2017-11-23 08:59:00,229 [salt.state       ][INFO    ][32353] Running state [/srv/glusterfs/glance] at time 08:59:00.228533
2017-11-23 08:59:00,229 [salt.state       ][INFO    ][32353] Executing state file.directory for /srv/glusterfs/glance
2017-11-23 08:59:00,229 [salt.state       ][INFO    ][32353] Directory /srv/glusterfs/glance is in the correct state
2017-11-23 08:59:00,229 [salt.state       ][INFO    ][32353] Completed state [/srv/glusterfs/glance] at time 08:59:00.229383 duration_in_ms=0.85
2017-11-23 08:59:00,230 [salt.state       ][INFO    ][32353] Running state [/srv/glusterfs/keystone-keys] at time 08:59:00.229587
2017-11-23 08:59:00,230 [salt.state       ][INFO    ][32353] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-23 08:59:00,230 [salt.state       ][INFO    ][32353] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-23 08:59:00,230 [salt.state       ][INFO    ][32353] Completed state [/srv/glusterfs/keystone-keys] at time 08:59:00.230406 duration_in_ms=0.818
2017-11-23 08:59:00,231 [salt.state       ][INFO    ][32353] Running state [/srv/glusterfs/nova_instances] at time 08:59:00.230614
2017-11-23 08:59:00,231 [salt.state       ][INFO    ][32353] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-23 08:59:00,231 [salt.state       ][INFO    ][32353] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-23 08:59:00,231 [salt.state       ][INFO    ][32353] Completed state [/srv/glusterfs/nova_instances] at time 08:59:00.231357 duration_in_ms=0.743
2017-11-23 08:59:00,232 [salt.state       ][INFO    ][32353] Running state [/srv/glusterfs/keystone-credential-keys] at time 08:59:00.231546
2017-11-23 08:59:00,232 [salt.state       ][INFO    ][32353] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-23 08:59:00,232 [salt.state       ][INFO    ][32353] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-23 08:59:00,232 [salt.state       ][INFO    ][32353] Completed state [/srv/glusterfs/keystone-credential-keys] at time 08:59:00.232330 duration_in_ms=0.783
2017-11-23 08:59:00,233 [salt.minion      ][INFO    ][32353] Returning information for job: 20171123085857256282
2017-11-23 08:59:01,567 [salt.minion      ][INFO    ][24012] User sudo_ubuntu Executing command test.ping with jid 20171123085901578645
2017-11-23 08:59:01,579 [salt.minion      ][INFO    ][32376] Starting a new job with PID 32376
2017-11-23 08:59:01,614 [salt.minion      ][INFO    ][32376] Returning information for job: 20171123085901578645
2017-11-23 08:59:10,173 [salt.minion      ][INFO    ][24012] User sudo_ubuntu Executing command state.sls with jid 20171123085910180876
2017-11-23 08:59:10,184 [salt.minion      ][INFO    ][32382] Starting a new job with PID 32382
2017-11-23 08:59:10,754 [salt.state       ][INFO    ][32382] Loading fresh modules for state activity
2017-11-23 08:59:10,784 [salt.fileclient  ][INFO    ][32382] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-11-23 08:59:10,829 [salt.fileclient  ][INFO    ][32382] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-23 08:59:10,910 [salt.fileclient  ][INFO    ][32382] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-23 08:59:10,935 [salt.fileclient  ][INFO    ][32382] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-23 08:59:11,237 [salt.state       ][INFO    ][32382] Running state [attr] at time 08:59:11.237311
2017-11-23 08:59:11,238 [salt.state       ][INFO    ][32382] Executing state pkg.installed for attr
2017-11-23 08:59:11,238 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-23 08:59:11,523 [salt.state       ][INFO    ][32382] Package attr is already installed
2017-11-23 08:59:11,524 [salt.state       ][INFO    ][32382] Completed state [attr] at time 08:59:11.523474 duration_in_ms=286.164
2017-11-23 08:59:11,524 [salt.state       ][INFO    ][32382] Running state [glusterfs-server] at time 08:59:11.523712
2017-11-23 08:59:11,524 [salt.state       ][INFO    ][32382] Executing state pkg.installed for glusterfs-server
2017-11-23 08:59:11,528 [salt.state       ][INFO    ][32382] Package glusterfs-server is already installed
2017-11-23 08:59:11,528 [salt.state       ][INFO    ][32382] Completed state [glusterfs-server] at time 08:59:11.527839 duration_in_ms=4.127
2017-11-23 08:59:11,528 [salt.state       ][INFO    ][32382] Running state [bc] at time 08:59:11.528014
2017-11-23 08:59:11,528 [salt.state       ][INFO    ][32382] Executing state pkg.installed for bc
2017-11-23 08:59:11,532 [salt.state       ][INFO    ][32382] Package bc is already installed
2017-11-23 08:59:11,532 [salt.state       ][INFO    ][32382] Completed state [bc] at time 08:59:11.532043 duration_in_ms=4.028
2017-11-23 08:59:11,533 [salt.state       ][INFO    ][32382] Running state [glusterfs-server] at time 08:59:11.532996
2017-11-23 08:59:11,533 [salt.state       ][INFO    ][32382] Executing state service.running for glusterfs-server
2017-11-23 08:59:11,534 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-23 08:59:11,550 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-23 08:59:11,557 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-23 08:59:11,567 [salt.state       ][INFO    ][32382] The service glusterfs-server is already running
2017-11-23 08:59:11,567 [salt.state       ][INFO    ][32382] Completed state [glusterfs-server] at time 08:59:11.566998 duration_in_ms=34.001
2017-11-23 08:59:11,569 [salt.state       ][INFO    ][32382] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 08:59:11.568535
2017-11-23 08:59:11,569 [salt.state       ][INFO    ][32382] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-23 08:59:11,571 [salt.state       ][INFO    ][32382] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-23 08:59:11,571 [salt.state       ][INFO    ][32382] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 08:59:11.571030 duration_in_ms=2.495
2017-11-23 08:59:11,571 [salt.state       ][INFO    ][32382] Running state [/srv/glusterfs/glance] at time 08:59:11.571241
2017-11-23 08:59:11,571 [salt.state       ][INFO    ][32382] Executing state file.directory for /srv/glusterfs/glance
2017-11-23 08:59:11,572 [salt.state       ][INFO    ][32382] Directory /srv/glusterfs/glance is in the correct state
2017-11-23 08:59:11,572 [salt.state       ][INFO    ][32382] Completed state [/srv/glusterfs/glance] at time 08:59:11.572050 duration_in_ms=0.809
2017-11-23 08:59:11,572 [salt.state       ][INFO    ][32382] Running state [/srv/glusterfs/keystone-keys] at time 08:59:11.572243
2017-11-23 08:59:11,572 [salt.state       ][INFO    ][32382] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-23 08:59:11,573 [salt.state       ][INFO    ][32382] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-23 08:59:11,573 [salt.state       ][INFO    ][32382] Completed state [/srv/glusterfs/keystone-keys] at time 08:59:11.572992 duration_in_ms=0.749
2017-11-23 08:59:11,573 [salt.state       ][INFO    ][32382] Running state [/srv/glusterfs/nova_instances] at time 08:59:11.573185
2017-11-23 08:59:11,573 [salt.state       ][INFO    ][32382] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-23 08:59:11,574 [salt.state       ][INFO    ][32382] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-23 08:59:11,574 [salt.state       ][INFO    ][32382] Completed state [/srv/glusterfs/nova_instances] at time 08:59:11.573962 duration_in_ms=0.777
2017-11-23 08:59:11,574 [salt.state       ][INFO    ][32382] Running state [/srv/glusterfs/keystone-credential-keys] at time 08:59:11.574152
2017-11-23 08:59:11,574 [salt.state       ][INFO    ][32382] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-23 08:59:11,575 [salt.state       ][INFO    ][32382] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-23 08:59:11,575 [salt.state       ][INFO    ][32382] Completed state [/srv/glusterfs/keystone-credential-keys] at time 08:59:11.574870 duration_in_ms=0.718
2017-11-23 08:59:11,667 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command ['git', '--version'] in directory '/root'
2017-11-23 08:59:11,713 [salt.state       ][INFO    ][32382] Running state [sleep 5] at time 08:59:11.712597
2017-11-23 08:59:11,713 [salt.state       ][INFO    ][32382] Executing state cmd.wait for sleep 5
2017-11-23 08:59:11,713 [salt.state       ][INFO    ][32382] No changes made for sleep 5
2017-11-23 08:59:11,713 [salt.state       ][INFO    ][32382] Completed state [sleep 5] at time 08:59:11.713277 duration_in_ms=0.681
2017-11-23 08:59:11,714 [salt.state       ][INFO    ][32382] Running state [192.168.10.143] at time 08:59:11.713842
2017-11-23 08:59:11,714 [salt.state       ][INFO    ][32382] Executing state glusterfs.peered for 192.168.10.143
2017-11-23 08:59:11,714 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:11,722 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:11,774 [salt.state       ][INFO    ][32382] Host 192.168.10.143 already peered
2017-11-23 08:59:11,774 [salt.state       ][INFO    ][32382] Completed state [192.168.10.143] at time 08:59:11.774340 duration_in_ms=60.498
2017-11-23 08:59:11,778 [salt.state       ][INFO    ][32382] Running state [192.168.10.142] at time 08:59:11.777500
2017-11-23 08:59:11,778 [salt.state       ][INFO    ][32382] Executing state glusterfs.peered for 192.168.10.142
2017-11-23 08:59:11,778 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:11,787 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:11,839 [salt.state       ][INFO    ][32382] Host 192.168.10.142 already peered
2017-11-23 08:59:11,840 [salt.state       ][INFO    ][32382] Completed state [192.168.10.142] at time 08:59:11.839656 duration_in_ms=62.155
2017-11-23 08:59:11,843 [salt.state       ][INFO    ][32382] Running state [192.168.10.141] at time 08:59:11.842858
2017-11-23 08:59:11,843 [salt.state       ][INFO    ][32382] Executing state glusterfs.peered for 192.168.10.141
2017-11-23 08:59:11,844 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:11,851 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:11,903 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:11,911 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:11,963 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:11,971 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:12,022 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:12,030 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:12,082 [salt.state       ][INFO    ][32382] Peering with localhost is not needed
2017-11-23 08:59:12,082 [salt.state       ][INFO    ][32382] Completed state [192.168.10.141] at time 08:59:12.082023 duration_in_ms=239.164
2017-11-23 08:59:12,083 [salt.state       ][INFO    ][32382] Running state [glance] at time 08:59:12.083072
2017-11-23 08:59:12,083 [salt.state       ][INFO    ][32382] Executing state glusterfs.created for glance
2017-11-23 08:59:12,084 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:12,091 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:12,143 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:12,151 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:12,207 [salt.state       ][INFO    ][32382] Volume glance already exists and is started.
2017-11-23 08:59:12,207 [salt.state       ][INFO    ][32382] Completed state [glance] at time 08:59:12.206799 duration_in_ms=123.727
2017-11-23 08:59:12,210 [salt.state       ][INFO    ][32382] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 08:59:12.210383
2017-11-23 08:59:12,211 [salt.state       ][INFO    ][32382] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-11-23 08:59:12,211 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-23 08:59:12,262 [salt.state       ][INFO    ][32382] unless execution succeeded
2017-11-23 08:59:12,262 [salt.state       ][INFO    ][32382] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 08:59:12.262207 duration_in_ms=51.823
2017-11-23 08:59:12,263 [salt.state       ][INFO    ][32382] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 08:59:12.262815
2017-11-23 08:59:12,263 [salt.state       ][INFO    ][32382] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-11-23 08:59:12,264 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-23 08:59:12,314 [salt.state       ][INFO    ][32382] unless execution succeeded
2017-11-23 08:59:12,314 [salt.state       ][INFO    ][32382] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 08:59:12.314186 duration_in_ms=51.369
2017-11-23 08:59:12,315 [salt.state       ][INFO    ][32382] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 08:59:12.314798
2017-11-23 08:59:12,315 [salt.state       ][INFO    ][32382] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-11-23 08:59:12,316 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-11-23 08:59:12,371 [salt.state       ][INFO    ][32382] unless execution succeeded
2017-11-23 08:59:12,371 [salt.state       ][INFO    ][32382] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 08:59:12.371148 duration_in_ms=56.349
2017-11-23 08:59:12,372 [salt.state       ][INFO    ][32382] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 08:59:12.371824
2017-11-23 08:59:12,372 [salt.state       ][INFO    ][32382] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-11-23 08:59:12,373 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-23 08:59:12,424 [salt.state       ][INFO    ][32382] unless execution succeeded
2017-11-23 08:59:12,424 [salt.state       ][INFO    ][32382] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 08:59:12.424408 duration_in_ms=52.584
2017-11-23 08:59:12,425 [salt.state       ][INFO    ][32382] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 08:59:12.424925
2017-11-23 08:59:12,425 [salt.state       ][INFO    ][32382] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-11-23 08:59:12,426 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-23 08:59:12,478 [salt.state       ][INFO    ][32382] unless execution succeeded
2017-11-23 08:59:12,478 [salt.state       ][INFO    ][32382] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 08:59:12.477915 duration_in_ms=52.99
2017-11-23 08:59:12,479 [salt.state       ][INFO    ][32382] Running state [glance] at time 08:59:12.479291
2017-11-23 08:59:12,480 [salt.state       ][INFO    ][32382] Executing state glusterfs.started for glance
2017-11-23 08:59:12,480 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:12,488 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:12,541 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:12,547 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:12,605 [salt.state       ][INFO    ][32382] Volume glance is already started
2017-11-23 08:59:12,606 [salt.state       ][INFO    ][32382] Completed state [glance] at time 08:59:12.605490 duration_in_ms=126.197
2017-11-23 08:59:12,607 [salt.state       ][INFO    ][32382] Running state [keystone-keys] at time 08:59:12.606709
2017-11-23 08:59:12,607 [salt.state       ][INFO    ][32382] Executing state glusterfs.created for keystone-keys
2017-11-23 08:59:12,607 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:12,615 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:12,668 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:12,676 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:12,731 [salt.state       ][INFO    ][32382] Volume keystone-keys already exists and is started.
2017-11-23 08:59:12,732 [salt.state       ][INFO    ][32382] Completed state [keystone-keys] at time 08:59:12.731581 duration_in_ms=124.871
2017-11-23 08:59:12,736 [salt.state       ][INFO    ][32382] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 08:59:12.735624
2017-11-23 08:59:12,736 [salt.state       ][INFO    ][32382] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-11-23 08:59:12,736 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-23 08:59:12,788 [salt.state       ][INFO    ][32382] unless execution succeeded
2017-11-23 08:59:12,789 [salt.state       ][INFO    ][32382] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 08:59:12.788697 duration_in_ms=53.072
2017-11-23 08:59:12,789 [salt.state       ][INFO    ][32382] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 08:59:12.789361
2017-11-23 08:59:12,790 [salt.state       ][INFO    ][32382] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-23 08:59:12,790 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-23 08:59:12,843 [salt.state       ][INFO    ][32382] unless execution succeeded
2017-11-23 08:59:12,843 [salt.state       ][INFO    ][32382] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 08:59:12.843278 duration_in_ms=53.917
2017-11-23 08:59:12,844 [salt.state       ][INFO    ][32382] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 08:59:12.843914
2017-11-23 08:59:12,844 [salt.state       ][INFO    ][32382] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-23 08:59:12,845 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-23 08:59:12,899 [salt.state       ][INFO    ][32382] unless execution succeeded
2017-11-23 08:59:12,899 [salt.state       ][INFO    ][32382] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 08:59:12.899331 duration_in_ms=55.417
2017-11-23 08:59:12,900 [salt.state       ][INFO    ][32382] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 08:59:12.899885
2017-11-23 08:59:12,900 [salt.state       ][INFO    ][32382] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-11-23 08:59:12,901 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-23 08:59:12,952 [salt.state       ][INFO    ][32382] unless execution succeeded
2017-11-23 08:59:12,952 [salt.state       ][INFO    ][32382] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 08:59:12.952200 duration_in_ms=52.316
2017-11-23 08:59:12,953 [salt.state       ][INFO    ][32382] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 08:59:12.952702
2017-11-23 08:59:12,953 [salt.state       ][INFO    ][32382] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-11-23 08:59:12,953 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-23 08:59:13,003 [salt.state       ][INFO    ][32382] unless execution succeeded
2017-11-23 08:59:13,003 [salt.state       ][INFO    ][32382] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 08:59:13.003168 duration_in_ms=50.466
2017-11-23 08:59:13,004 [salt.state       ][INFO    ][32382] Running state [keystone-keys] at time 08:59:13.004379
2017-11-23 08:59:13,005 [salt.state       ][INFO    ][32382] Executing state glusterfs.started for keystone-keys
2017-11-23 08:59:13,005 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:13,012 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:13,064 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:13,072 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:13,131 [salt.state       ][INFO    ][32382] Volume keystone-keys is already started
2017-11-23 08:59:13,132 [salt.state       ][INFO    ][32382] Completed state [keystone-keys] at time 08:59:13.131760 duration_in_ms=127.38
2017-11-23 08:59:13,134 [salt.state       ][INFO    ][32382] Running state [nova_instances] at time 08:59:13.134181
2017-11-23 08:59:13,135 [salt.state       ][INFO    ][32382] Executing state glusterfs.created for nova_instances
2017-11-23 08:59:13,136 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:13,144 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:13,195 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:13,204 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:13,260 [salt.state       ][INFO    ][32382] Volume nova_instances already exists and is started.
2017-11-23 08:59:13,260 [salt.state       ][INFO    ][32382] Completed state [nova_instances] at time 08:59:13.260403 duration_in_ms=126.222
2017-11-23 08:59:13,265 [salt.state       ][INFO    ][32382] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 08:59:13.264583
2017-11-23 08:59:13,265 [salt.state       ][INFO    ][32382] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-11-23 08:59:13,266 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-23 08:59:13,318 [salt.state       ][INFO    ][32382] unless execution succeeded
2017-11-23 08:59:13,318 [salt.state       ][INFO    ][32382] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 08:59:13.318210 duration_in_ms=53.627
2017-11-23 08:59:13,319 [salt.state       ][INFO    ][32382] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 08:59:13.318866
2017-11-23 08:59:13,319 [salt.state       ][INFO    ][32382] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-11-23 08:59:13,320 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-11-23 08:59:13,373 [salt.state       ][INFO    ][32382] unless execution succeeded
2017-11-23 08:59:13,373 [salt.state       ][INFO    ][32382] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 08:59:13.373174 duration_in_ms=54.307
2017-11-23 08:59:13,374 [salt.state       ][INFO    ][32382] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 08:59:13.373957
2017-11-23 08:59:13,374 [salt.state       ][INFO    ][32382] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-11-23 08:59:13,375 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-11-23 08:59:13,428 [salt.state       ][INFO    ][32382] unless execution succeeded
2017-11-23 08:59:13,428 [salt.state       ][INFO    ][32382] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 08:59:13.427915 duration_in_ms=53.959
2017-11-23 08:59:13,428 [salt.state       ][INFO    ][32382] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 08:59:13.428439
2017-11-23 08:59:13,429 [salt.state       ][INFO    ][32382] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-11-23 08:59:13,429 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-11-23 08:59:13,482 [salt.state       ][INFO    ][32382] unless execution succeeded
2017-11-23 08:59:13,483 [salt.state       ][INFO    ][32382] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 08:59:13.482465 duration_in_ms=54.024
2017-11-23 08:59:13,483 [salt.state       ][INFO    ][32382] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 08:59:13.483123
2017-11-23 08:59:13,483 [salt.state       ][INFO    ][32382] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-11-23 08:59:13,484 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-23 08:59:13,538 [salt.state       ][INFO    ][32382] unless execution succeeded
2017-11-23 08:59:13,538 [salt.state       ][INFO    ][32382] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 08:59:13.537780 duration_in_ms=54.657
2017-11-23 08:59:13,539 [salt.state       ][INFO    ][32382] Running state [nova_instances] at time 08:59:13.539080
2017-11-23 08:59:13,539 [salt.state       ][INFO    ][32382] Executing state glusterfs.started for nova_instances
2017-11-23 08:59:13,540 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:13,548 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:13,600 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:13,609 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:13,665 [salt.state       ][INFO    ][32382] Volume nova_instances is already started
2017-11-23 08:59:13,665 [salt.state       ][INFO    ][32382] Completed state [nova_instances] at time 08:59:13.664720 duration_in_ms=125.639
2017-11-23 08:59:13,666 [salt.state       ][INFO    ][32382] Running state [keystone-credential-keys] at time 08:59:13.665931
2017-11-23 08:59:13,666 [salt.state       ][INFO    ][32382] Executing state glusterfs.created for keystone-credential-keys
2017-11-23 08:59:13,667 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:13,674 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:13,726 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:13,734 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:13,790 [salt.state       ][INFO    ][32382] Volume keystone-credential-keys already exists and is started.
2017-11-23 08:59:13,790 [salt.state       ][INFO    ][32382] Completed state [keystone-credential-keys] at time 08:59:13.790390 duration_in_ms=124.459
2017-11-23 08:59:13,795 [salt.state       ][INFO    ][32382] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 08:59:13.794720
2017-11-23 08:59:13,795 [salt.state       ][INFO    ][32382] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-11-23 08:59:13,796 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-23 08:59:13,847 [salt.state       ][INFO    ][32382] unless execution succeeded
2017-11-23 08:59:13,847 [salt.state       ][INFO    ][32382] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 08:59:13.847366 duration_in_ms=52.645
2017-11-23 08:59:13,848 [salt.state       ][INFO    ][32382] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 08:59:13.847957
2017-11-23 08:59:13,848 [salt.state       ][INFO    ][32382] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-23 08:59:13,849 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-23 08:59:13,901 [salt.state       ][INFO    ][32382] unless execution succeeded
2017-11-23 08:59:13,901 [salt.state       ][INFO    ][32382] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 08:59:13.901194 duration_in_ms=53.237
2017-11-23 08:59:13,902 [salt.state       ][INFO    ][32382] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 08:59:13.901799
2017-11-23 08:59:13,902 [salt.state       ][INFO    ][32382] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-11-23 08:59:13,903 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-23 08:59:13,954 [salt.state       ][INFO    ][32382] unless execution succeeded
2017-11-23 08:59:13,955 [salt.state       ][INFO    ][32382] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 08:59:13.954522 duration_in_ms=52.723
2017-11-23 08:59:13,955 [salt.state       ][INFO    ][32382] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 08:59:13.955197
2017-11-23 08:59:13,955 [salt.state       ][INFO    ][32382] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-23 08:59:13,956 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-23 08:59:14,008 [salt.state       ][INFO    ][32382] unless execution succeeded
2017-11-23 08:59:14,008 [salt.state       ][INFO    ][32382] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 08:59:14.007971 duration_in_ms=52.774
2017-11-23 08:59:14,009 [salt.state       ][INFO    ][32382] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 08:59:14.008601
2017-11-23 08:59:14,009 [salt.state       ][INFO    ][32382] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-11-23 08:59:14,009 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-23 08:59:14,062 [salt.state       ][INFO    ][32382] unless execution succeeded
2017-11-23 08:59:14,063 [salt.state       ][INFO    ][32382] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 08:59:14.062544 duration_in_ms=53.943
2017-11-23 08:59:14,064 [salt.state       ][INFO    ][32382] Running state [keystone-credential-keys] at time 08:59:14.063800
2017-11-23 08:59:14,064 [salt.state       ][INFO    ][32382] Executing state glusterfs.started for keystone-credential-keys
2017-11-23 08:59:14,065 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:14,072 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:14,124 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:14,132 [salt.loaded.int.module.cmdmod][INFO    ][32382] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:14,188 [salt.state       ][INFO    ][32382] Volume keystone-credential-keys is already started
2017-11-23 08:59:14,189 [salt.state       ][INFO    ][32382] Completed state [keystone-credential-keys] at time 08:59:14.188596 duration_in_ms=124.794
2017-11-23 08:59:14,192 [salt.minion      ][INFO    ][32382] Returning information for job: 20171123085910180876
2017-11-23 08:59:15,232 [salt.minion      ][INFO    ][24012] User sudo_ubuntu Executing command test.ping with jid 20171123085915241600
2017-11-23 08:59:15,244 [salt.minion      ][INFO    ][32765] Starting a new job with PID 32765
2017-11-23 08:59:15,279 [salt.minion      ][INFO    ][32765] Returning information for job: 20171123085915241600
2017-11-23 08:59:15,928 [salt.minion      ][INFO    ][24012] User sudo_ubuntu Executing command cmd.run with jid 20171123085915938485
2017-11-23 08:59:15,939 [salt.minion      ][INFO    ][32770] Starting a new job with PID 32770
2017-11-23 08:59:15,942 [salt.loaded.int.module.cmdmod][INFO    ][32770] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-11-23 08:59:16,055 [salt.minion      ][INFO    ][32770] Returning information for job: 20171123085915938485
2017-11-23 09:23:01,173 [salt.minion      ][INFO    ][24012] User sudo_ubuntu Executing command cp.push_dir with jid 20171123092301171265
2017-11-23 09:23:01,191 [salt.minion      ][INFO    ][32982] Starting a new job with PID 32982
