2017-11-23 07:40:38,578 [salt.cli.daemons ][WARNING ][2173] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-23 07:41:48,098 [salt.state       ][ERROR   ][3693] No contents found in top file
2017-11-23 07:43:39,608 [salt.utils.parsers][WARNING ][2173] Minion received a SIGTERM. Exiting.
2017-11-23 07:48:07,506 [salt.cli.daemons ][WARNING ][3244] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-23 07:50:38,332 [py.warnings      ][WARNING ][16066] /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,146 [salt.loaded.int.module.cmdmod][ERROR   ][16066] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-23 07:54:52,146 [salt.loaded.int.module.cmdmod][ERROR   ][16066] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-23 07:54:56,640 [salt.loaded.int.module.cmdmod][ERROR   ][16066] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-23 07:54:56,642 [salt.loaded.int.module.cmdmod][ERROR   ][16066] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-23 07:55:01,248 [salt.loaded.int.module.cmdmod][ERROR   ][16066] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-23 07:55:01,248 [salt.loaded.int.module.cmdmod][ERROR   ][16066] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-23 07:55:05,672 [salt.loaded.int.module.cmdmod][ERROR   ][16066] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-23 07:55:05,672 [salt.loaded.int.module.cmdmod][ERROR   ][16066] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-23 07:55:09,160 [salt.loaded.int.module.cmdmod][ERROR   ][16066] 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:11,718 [salt.loaded.int.module.cmdmod][INFO    ][23468] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-23 07:55:11,725 [salt.loaded.int.module.cmdmod][INFO    ][23468] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-23 07:55:11,734 [salt.loaded.int.module.cmdmod][INFO    ][23468] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-11-23 07:55:11,742 [salt.utils.parsers][WARNING ][3244] Minion received a SIGTERM. Exiting.
2017-11-23 07:55:12,063 [salt.cli.daemons ][INFO    ][23545] Setting up the Salt Minion "kvm02.baremetal-mcp-ocata-odl-ha.local"
2017-11-23 07:55:12,731 [salt.minion      ][INFO    ][23545] Creating minion process manager
2017-11-23 07:55:12,731 [salt.cli.daemons ][WARNING ][23545] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-23 07:55:12,731 [salt.cli.daemons ][INFO    ][23545] The Salt Minion is starting up
2017-11-23 07:55:12,732 [salt.minion      ][INFO    ][23545] Minion is starting as user 'root'
2017-11-23 07:55:12,732 [salt.utils.event ][INFO    ][23545] Starting pull socket on /var/run/salt/minion/minion_event_0607a05f39_pull.ipc
2017-11-23 07:55:13,869 [salt.loaded.int.module.cmdmod][INFO    ][23545] Executing command ['date', '+%z'] in directory '/root'
2017-11-23 07:55:13,881 [salt.utils.schedule][INFO    ][23545] Updating job settings for scheduled job: __mine_interval
2017-11-23 07:55:13,884 [salt.minion      ][INFO    ][23545] Added mine.update to scheduler
2017-11-23 07:55:13,914 [salt.minion      ][INFO    ][23545] Minion is ready to receive requests!
2017-11-23 07:55:14,915 [salt.utils.schedule][INFO    ][23545] Running scheduled job: __mine_interval
2017-11-23 07:55:19,774 [salt.minion      ][INFO    ][23545] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171123075519764988
2017-11-23 07:55:19,785 [salt.minion      ][INFO    ][23644] Starting a new job with PID 23644
2017-11-23 07:55:22,083 [salt.state       ][INFO    ][23644] Loading fresh modules for state activity
2017-11-23 07:55:22,121 [salt.state       ][ERROR   ][23644] No contents found in top file
2017-11-23 07:55:22,122 [salt.utils.extmods][INFO    ][23644] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-11-23 07:55:22,125 [salt.utils.extmods][INFO    ][23644] Syncing beacons for environment 'base'
2017-11-23 07:55:22,125 [salt.utils.extmods][INFO    ][23644] Loading cache from salt://_beacons, for base)
2017-11-23 07:55:22,125 [salt.fileclient  ][INFO    ][23644] Caching directory '_beacons/' for environment 'base'
2017-11-23 07:55:22,168 [salt.utils.extmods][INFO    ][23644] Syncing modules for environment 'base'
2017-11-23 07:55:22,168 [salt.utils.extmods][INFO    ][23644] Loading cache from salt://_modules, for base)
2017-11-23 07:55:22,168 [salt.fileclient  ][INFO    ][23644] Caching directory '_modules/' for environment 'base'
2017-11-23 07:55:22,213 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-11-23 07:55:22,224 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-11-23 07:55:22,236 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-11-23 07:55:22,250 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-11-23 07:55:22,261 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-11-23 07:55:22,270 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-11-23 07:55:22,281 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-11-23 07:55:22,292 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-11-23 07:55:22,302 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-11-23 07:55:22,311 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-11-23 07:55:22,422 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-11-23 07:55:22,434 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-11-23 07:55:22,446 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-11-23 07:55:22,457 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-11-23 07:55:22,470 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-11-23 07:55:22,485 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-11-23 07:55:22,498 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-11-23 07:55:22,513 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-11-23 07:55:22,522 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-11-23 07:55:22,534 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-11-23 07:55:22,546 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-11-23 07:55:22,558 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-11-23 07:55:22,569 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-11-23 07:55:22,581 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-11-23 07:55:22,594 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-11-23 07:55:22,606 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-11-23 07:55:22,621 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-11-23 07:55:22,632 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-11-23 07:55:22,655 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-11-23 07:55:22,669 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-11-23 07:55:22,680 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-11-23 07:55:22,694 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-11-23 07:55:22,707 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-11-23 07:55:22,711 [salt.utils.extmods][INFO    ][23644] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-11-23 07:55:22,711 [salt.utils.extmods][INFO    ][23644] 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:22,712 [salt.utils.extmods][INFO    ][23644] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-11-23 07:55:22,712 [salt.utils.extmods][INFO    ][23644] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-11-23 07:55:22,713 [salt.utils.extmods][INFO    ][23644] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-11-23 07:55:22,714 [salt.utils.extmods][INFO    ][23644] 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:22,714 [salt.utils.extmods][INFO    ][23644] 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:22,714 [salt.utils.extmods][INFO    ][23644] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-11-23 07:55:22,715 [salt.utils.extmods][INFO    ][23644] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-11-23 07:55:22,716 [salt.utils.extmods][INFO    ][23644] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-11-23 07:55:22,716 [salt.utils.extmods][INFO    ][23644] 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:22,717 [salt.utils.extmods][INFO    ][23644] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-11-23 07:55:22,717 [salt.utils.extmods][INFO    ][23644] 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:22,717 [salt.utils.extmods][INFO    ][23644] 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:22,718 [salt.utils.extmods][INFO    ][23644] 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:22,718 [salt.utils.extmods][INFO    ][23644] 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:22,719 [salt.utils.extmods][INFO    ][23644] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-11-23 07:55:22,719 [salt.utils.extmods][INFO    ][23644] 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:22,720 [salt.utils.extmods][INFO    ][23644] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2017-11-23 07:55:22,720 [salt.utils.extmods][INFO    ][23644] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-11-23 07:55:22,721 [salt.utils.extmods][INFO    ][23644] 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:22,721 [salt.utils.extmods][INFO    ][23644] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-11-23 07:55:22,722 [salt.utils.extmods][INFO    ][23644] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-11-23 07:55:22,723 [salt.utils.extmods][INFO    ][23644] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-11-23 07:55:22,723 [salt.utils.extmods][INFO    ][23644] 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:22,724 [salt.utils.extmods][INFO    ][23644] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-11-23 07:55:22,724 [salt.utils.extmods][INFO    ][23644] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-11-23 07:55:22,725 [salt.utils.extmods][INFO    ][23644] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-11-23 07:55:22,725 [salt.utils.extmods][INFO    ][23644] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-11-23 07:55:22,726 [salt.utils.extmods][INFO    ][23644] 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:22,726 [salt.utils.extmods][INFO    ][23644] 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:22,726 [salt.utils.extmods][INFO    ][23644] 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:22,727 [salt.utils.extmods][INFO    ][23644] 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:22,727 [salt.utils.extmods][INFO    ][23644] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-11-23 07:55:22,728 [salt.utils.extmods][INFO    ][23644] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-11-23 07:55:22,734 [salt.utils.extmods][INFO    ][23644] Syncing states for environment 'base'
2017-11-23 07:55:22,734 [salt.utils.extmods][INFO    ][23644] Loading cache from salt://_states, for base)
2017-11-23 07:55:22,734 [salt.fileclient  ][INFO    ][23644] Caching directory '_states/' for environment 'base'
2017-11-23 07:55:22,782 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-11-23 07:55:22,797 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-11-23 07:55:22,810 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-11-23 07:55:22,821 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-11-23 07:55:22,830 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-11-23 07:55:22,839 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-11-23 07:55:22,858 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-11-23 07:55:22,868 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-11-23 07:55:22,878 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-11-23 07:55:22,889 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-11-23 07:55:22,899 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-11-23 07:55:22,910 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_states/jenkins_globalenvprop.py'
2017-11-23 07:55:22,922 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-11-23 07:55:22,933 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-11-23 07:55:22,945 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-11-23 07:55:22,958 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-11-23 07:55:22,969 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-11-23 07:55:23,382 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-11-23 07:55:23,394 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-11-23 07:55:23,405 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-11-23 07:55:23,418 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-11-23 07:55:23,429 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-11-23 07:55:23,440 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-11-23 07:55:23,449 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-11-23 07:55:23,470 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-11-23 07:55:23,481 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-11-23 07:55:23,499 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-11-23 07:55:23,510 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-11-23 07:55:23,523 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-11-23 07:55:23,533 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-11-23 07:55:23,537 [salt.utils.extmods][INFO    ][23644] 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,537 [salt.utils.extmods][INFO    ][23644] 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,537 [salt.utils.extmods][INFO    ][23644] 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,538 [salt.utils.extmods][INFO    ][23644] 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,538 [salt.utils.extmods][INFO    ][23644] 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,538 [salt.utils.extmods][INFO    ][23644] 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,539 [salt.utils.extmods][INFO    ][23644] 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,539 [salt.utils.extmods][INFO    ][23644] 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,539 [salt.utils.extmods][INFO    ][23644] 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,539 [salt.utils.extmods][INFO    ][23644] 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,539 [salt.utils.extmods][INFO    ][23644] 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,540 [salt.utils.extmods][INFO    ][23644] 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,540 [salt.utils.extmods][INFO    ][23644] 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,540 [salt.utils.extmods][INFO    ][23644] 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,540 [salt.utils.extmods][INFO    ][23644] 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,541 [salt.utils.extmods][INFO    ][23644] 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,541 [salt.utils.extmods][INFO    ][23644] 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,541 [salt.utils.extmods][INFO    ][23644] 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,541 [salt.utils.extmods][INFO    ][23644] 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,542 [salt.utils.extmods][INFO    ][23644] 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,542 [salt.utils.extmods][INFO    ][23644] 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,542 [salt.utils.extmods][INFO    ][23644] 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,542 [salt.utils.extmods][INFO    ][23644] 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,542 [salt.utils.extmods][INFO    ][23644] 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,543 [salt.utils.extmods][INFO    ][23644] 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,543 [salt.utils.extmods][INFO    ][23644] 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,543 [salt.utils.extmods][INFO    ][23644] 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,543 [salt.utils.extmods][INFO    ][23644] 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,544 [salt.utils.extmods][INFO    ][23644] 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,544 [salt.utils.extmods][INFO    ][23644] 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,544 [salt.utils.extmods][INFO    ][23644] 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,547 [salt.utils.extmods][INFO    ][23644] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-11-23 07:55:23,549 [salt.utils.extmods][INFO    ][23644] Syncing sdb for environment 'base'
2017-11-23 07:55:23,550 [salt.utils.extmods][INFO    ][23644] Loading cache from salt://_sdb, for base)
2017-11-23 07:55:23,550 [salt.fileclient  ][INFO    ][23644] Caching directory '_sdb/' for environment 'base'
2017-11-23 07:55:23,599 [salt.utils.extmods][INFO    ][23644] Syncing grains for environment 'base'
2017-11-23 07:55:23,599 [salt.utils.extmods][INFO    ][23644] Loading cache from salt://_grains, for base)
2017-11-23 07:55:23,599 [salt.fileclient  ][INFO    ][23644] Caching directory '_grains/' for environment 'base'
2017-11-23 07:55:23,645 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-11-23 07:55:23,657 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-11-23 07:55:23,666 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-11-23 07:55:23,678 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-11-23 07:55:23,688 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-11-23 07:55:23,703 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-11-23 07:55:23,714 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-11-23 07:55:23,725 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-11-23 07:55:23,737 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-11-23 07:55:23,750 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-11-23 07:55:23,761 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-11-23 07:55:23,771 [salt.fileclient  ][INFO    ][23644] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-11-23 07:55:23,775 [salt.utils.extmods][INFO    ][23644] 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:23,775 [salt.utils.extmods][INFO    ][23644] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-11-23 07:55:23,776 [salt.utils.extmods][INFO    ][23644] 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:23,776 [salt.utils.extmods][INFO    ][23644] 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:23,777 [salt.utils.extmods][INFO    ][23644] 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:23,777 [salt.utils.extmods][INFO    ][23644] 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:23,777 [salt.utils.extmods][INFO    ][23644] 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:23,778 [salt.utils.extmods][INFO    ][23644] 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:23,778 [salt.utils.extmods][INFO    ][23644] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-11-23 07:55:23,778 [salt.utils.extmods][INFO    ][23644] 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:23,779 [salt.utils.extmods][INFO    ][23644] 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:23,779 [salt.utils.extmods][INFO    ][23644] 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:23,780 [salt.utils.extmods][INFO    ][23644] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-11-23 07:55:23,783 [salt.utils.extmods][INFO    ][23644] Syncing renderers for environment 'base'
2017-11-23 07:55:23,784 [salt.utils.extmods][INFO    ][23644] Loading cache from salt://_renderers, for base)
2017-11-23 07:55:23,784 [salt.fileclient  ][INFO    ][23644] Caching directory '_renderers/' for environment 'base'
2017-11-23 07:55:23,819 [salt.utils.extmods][INFO    ][23644] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-11-23 07:55:23,822 [salt.utils.extmods][INFO    ][23644] Syncing returners for environment 'base'
2017-11-23 07:55:23,822 [salt.utils.extmods][INFO    ][23644] Loading cache from salt://_returners, for base)
2017-11-23 07:55:23,822 [salt.fileclient  ][INFO    ][23644] Caching directory '_returners/' for environment 'base'
2017-11-23 07:55:23,852 [salt.utils.extmods][INFO    ][23644] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-11-23 07:55:23,855 [salt.utils.extmods][INFO    ][23644] Syncing output for environment 'base'
2017-11-23 07:55:23,855 [salt.utils.extmods][INFO    ][23644] Loading cache from salt://_output, for base)
2017-11-23 07:55:23,855 [salt.fileclient  ][INFO    ][23644] Caching directory '_output/' for environment 'base'
2017-11-23 07:55:23,887 [salt.utils.extmods][INFO    ][23644] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-11-23 07:55:23,890 [salt.utils.extmods][INFO    ][23644] Syncing utils for environment 'base'
2017-11-23 07:55:23,890 [salt.utils.extmods][INFO    ][23644] Loading cache from salt://_utils, for base)
2017-11-23 07:55:23,890 [salt.fileclient  ][INFO    ][23644] Caching directory '_utils/' for environment 'base'
2017-11-23 07:55:23,923 [salt.utils.extmods][INFO    ][23644] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-11-23 07:55:23,926 [salt.utils.extmods][INFO    ][23644] Syncing log_handlers for environment 'base'
2017-11-23 07:55:23,926 [salt.utils.extmods][INFO    ][23644] Loading cache from salt://_log_handlers, for base)
2017-11-23 07:55:23,926 [salt.fileclient  ][INFO    ][23644] Caching directory '_log_handlers/' for environment 'base'
2017-11-23 07:55:23,965 [salt.utils.extmods][INFO    ][23644] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-11-23 07:55:23,968 [salt.utils.extmods][INFO    ][23644] Syncing proxy for environment 'base'
2017-11-23 07:55:23,968 [salt.utils.extmods][INFO    ][23644] Loading cache from salt://_proxy, for base)
2017-11-23 07:55:23,968 [salt.fileclient  ][INFO    ][23644] Caching directory '_proxy/' for environment 'base'
2017-11-23 07:55:23,999 [salt.utils.extmods][INFO    ][23644] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-11-23 07:55:24,002 [salt.utils.extmods][INFO    ][23644] Syncing engines for environment 'base'
2017-11-23 07:55:24,003 [salt.utils.extmods][INFO    ][23644] Loading cache from salt://_engines, for base)
2017-11-23 07:55:24,003 [salt.fileclient  ][INFO    ][23644] Caching directory '_engines/' for environment 'base'
2017-11-23 07:55:24,038 [salt.minion      ][INFO    ][23644] Returning information for job: 20171123075519764988
2017-11-23 07:55:25,086 [salt.minion      ][INFO    ][23545] User sudo_ubuntu Executing command state.sls with jid 20171123075525078109
2017-11-23 07:55:25,095 [salt.minion      ][INFO    ][23709] Starting a new job with PID 23709
2017-11-23 07:55:25,737 [salt.state       ][INFO    ][23709] Loading fresh modules for state activity
2017-11-23 07:55:25,766 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-11-23 07:55:25,785 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-11-23 07:55:25,816 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-23 07:55:25,957 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-11-23 07:55:25,973 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-11-23 07:55:26,006 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-23 07:55:26,072 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-23 07:55:26,094 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-23 07:55:26,150 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-23 07:55:26,170 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-23 07:55:26,184 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-23 07:55:26,201 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-23 07:55:26,211 [salt.loaded.int.module.cmdmod][INFO    ][23709] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-23 07:55:26,231 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-23 07:55:26,250 [py.warnings      ][WARNING ][23709] /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,251 [salt.loaded.int.module.cmdmod][INFO    ][23709] Executing command 'salt-minion --version' in directory '/root'
2017-11-23 07:55:26,515 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-23 07:55:26,537 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-23 07:55:26,549 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-23 07:55:26,561 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-23 07:55:26,606 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-11-23 07:55:26,621 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-11-23 07:55:26,649 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-23 07:55:26,695 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-23 07:55:26,769 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-11-23 07:55:26,794 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-23 07:55:26,862 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-23 07:55:26,885 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-23 07:55:26,942 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-23 07:55:26,963 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-23 07:55:26,977 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-23 07:55:26,994 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-23 07:55:27,002 [salt.loaded.int.module.cmdmod][INFO    ][23709] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-23 07:55:27,025 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-23 07:55:27,043 [salt.loaded.int.module.cmdmod][INFO    ][23709] Executing command 'salt-minion --version' in directory '/root'
2017-11-23 07:55:27,293 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-23 07:55:27,308 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-23 07:55:27,318 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-23 07:55:27,328 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-23 07:55:27,369 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-11-23 07:55:27,380 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-11-23 07:55:27,405 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-23 07:55:27,446 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-23 07:55:27,522 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-11-23 07:55:27,602 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-23 07:55:27,971 [salt.state       ][INFO    ][23709] Running state [salt-minion] at time 07:55:27.970734
2017-11-23 07:55:27,971 [salt.state       ][INFO    ][23709] Executing state pkg.installed for salt-minion
2017-11-23 07:55:27,972 [salt.loaded.int.module.cmdmod][INFO    ][23709] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-23 07:55:28,242 [salt.state       ][INFO    ][23709] Package salt-minion is already installed
2017-11-23 07:55:28,243 [salt.state       ][INFO    ][23709] Completed state [salt-minion] at time 07:55:28.242754 duration_in_ms=272.021
2017-11-23 07:55:28,243 [salt.state       ][INFO    ][23709] Running state [salt_minion_dependency_packages] at time 07:55:28.243022
2017-11-23 07:55:28,243 [salt.state       ][INFO    ][23709] Executing state pkg.installed for salt_minion_dependency_packages
2017-11-23 07:55:28,247 [salt.state       ][INFO    ][23709] All specified packages are already installed
2017-11-23 07:55:28,247 [salt.state       ][INFO    ][23709] Completed state [salt_minion_dependency_packages] at time 07:55:28.247176 duration_in_ms=4.155
2017-11-23 07:55:28,249 [salt.state       ][INFO    ][23709] Running state [/etc/salt/minion.d/minion.conf] at time 07:55:28.248828
2017-11-23 07:55:28,249 [salt.state       ][INFO    ][23709] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-11-23 07:55:28,275 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-11-23 07:55:28,329 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-23 07:55:28,384 [salt.fileclient  ][INFO    ][23709] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-23 07:55:28,431 [salt.state       ][INFO    ][23709] File /etc/salt/minion.d/minion.conf is in the correct state
2017-11-23 07:55:28,431 [salt.state       ][INFO    ][23709] Completed state [/etc/salt/minion.d/minion.conf] at time 07:55:28.431134 duration_in_ms=182.306
2017-11-23 07:55:28,432 [salt.state       ][INFO    ][23709] Running state [/etc/salt/minion.d/_virt.conf] at time 07:55:28.431499
2017-11-23 07:55:28,432 [salt.state       ][INFO    ][23709] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-11-23 07:55:28,432 [salt.state       ][INFO    ][23709] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-11-23 07:55:28,433 [salt.state       ][INFO    ][23709] Completed state [/etc/salt/minion.d/_virt.conf] at time 07:55:28.432539 duration_in_ms=1.04
2017-11-23 07:55:28,434 [salt.state       ][INFO    ][23709] Running state [salt-minion] at time 07:55:28.434158
2017-11-23 07:55:28,434 [salt.state       ][INFO    ][23709] Executing state service.running for salt-minion
2017-11-23 07:55:28,435 [salt.loaded.int.module.cmdmod][INFO    ][23709] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-23 07:55:28,447 [salt.loaded.int.module.cmdmod][INFO    ][23709] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-11-23 07:55:28,453 [salt.loaded.int.module.cmdmod][INFO    ][23709] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-23 07:55:28,459 [salt.state       ][INFO    ][23709] The service salt-minion is already running
2017-11-23 07:55:28,459 [salt.state       ][INFO    ][23709] Completed state [salt-minion] at time 07:55:28.458808 duration_in_ms=24.649
2017-11-23 07:55:28,460 [salt.state       ][INFO    ][23709] Running state [/etc/salt/grains.d] at time 07:55:28.460313
2017-11-23 07:55:28,461 [salt.state       ][INFO    ][23709] Executing state file.directory for /etc/salt/grains.d
2017-11-23 07:55:28,461 [salt.state       ][INFO    ][23709] Directory /etc/salt/grains.d is in the correct state
2017-11-23 07:55:28,461 [salt.state       ][INFO    ][23709] Completed state [/etc/salt/grains.d] at time 07:55:28.461309 duration_in_ms=0.995
2017-11-23 07:55:28,462 [salt.state       ][INFO    ][23709] Running state [/etc/salt/grains] at time 07:55:28.461858
2017-11-23 07:55:28,462 [salt.state       ][INFO    ][23709] Executing state file.managed for /etc/salt/grains
2017-11-23 07:55:28,462 [salt.state       ][INFO    ][23709] File /etc/salt/grains exists with proper permissions. No changes made.
2017-11-23 07:55:28,463 [salt.state       ][INFO    ][23709] Completed state [/etc/salt/grains] at time 07:55:28.462616 duration_in_ms=0.758
2017-11-23 07:55:28,463 [salt.state       ][INFO    ][23709] Running state [/etc/salt/grains.d/placeholder] at time 07:55:28.462986
2017-11-23 07:55:28,463 [salt.state       ][INFO    ][23709] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-11-23 07:55:28,464 [salt.state       ][INFO    ][23709] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-11-23 07:55:28,464 [salt.state       ][INFO    ][23709] Completed state [/etc/salt/grains.d/placeholder] at time 07:55:28.463724 duration_in_ms=0.737
2017-11-23 07:55:28,464 [salt.state       ][INFO    ][23709] Running state [/etc/salt/grains.d/sphinx] at time 07:55:28.464121
2017-11-23 07:55:28,464 [salt.state       ][INFO    ][23709] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-11-23 07:55:28,466 [salt.state       ][INFO    ][23709] File changed:
--- 
+++ 
@@ -49,7 +49,6 @@
               - 127.0.0.1
               - 192.168.10.142
               - 192.168.11.252
-              - 192.168.122.1
         system:
           name: System
           param:

2017-11-23 07:55:28,466 [salt.state       ][INFO    ][23709] Completed state [/etc/salt/grains.d/sphinx] at time 07:55:28.465928 duration_in_ms=1.807
2017-11-23 07:55:28,467 [salt.state       ][INFO    ][23709] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 07:55:28.466743
2017-11-23 07:55:28,467 [salt.state       ][INFO    ][23709] 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,467 [salt.state       ][INFO    ][23709] 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,467 [salt.state       ][INFO    ][23709] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 07:55:28.467325 duration_in_ms=0.582
2017-11-23 07:55:28,468 [salt.state       ][INFO    ][23709] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 07:55:28.467490
2017-11-23 07:55:28,468 [salt.state       ][INFO    ][23709] 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,468 [salt.loaded.int.module.cmdmod][INFO    ][23709] 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,542 [salt.state       ][INFO    ][23709] {'pid': 23787, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-11-23 07:55:28,543 [salt.state       ][INFO    ][23709] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 07:55:28.542769 duration_in_ms=75.278
2017-11-23 07:55:28,543 [salt.state       ][INFO    ][23709] Running state [/etc/salt/grains.d/dns_records] at time 07:55:28.543253
2017-11-23 07:55:28,544 [salt.state       ][INFO    ][23709] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-11-23 07:55:28,544 [salt.state       ][INFO    ][23709] File /etc/salt/grains.d/dns_records is in the correct state
2017-11-23 07:55:28,545 [salt.state       ][INFO    ][23709] Completed state [/etc/salt/grains.d/dns_records] at time 07:55:28.544590 duration_in_ms=1.336
2017-11-23 07:55:28,545 [salt.state       ][INFO    ][23709] 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.545376
2017-11-23 07:55:28,546 [salt.state       ][INFO    ][23709] 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,546 [salt.state       ][INFO    ][23709] 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,546 [salt.state       ][INFO    ][23709] 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.545997 duration_in_ms=0.621
2017-11-23 07:55:28,546 [salt.state       ][INFO    ][23709] Running state [/etc/salt/grains.d/salt] at time 07:55:28.546353
2017-11-23 07:55:28,547 [salt.state       ][INFO    ][23709] Executing state file.managed for /etc/salt/grains.d/salt
2017-11-23 07:55:28,547 [salt.state       ][INFO    ][23709] File /etc/salt/grains.d/salt is in the correct state
2017-11-23 07:55:28,547 [salt.state       ][INFO    ][23709] Completed state [/etc/salt/grains.d/salt] at time 07:55:28.547406 duration_in_ms=1.053
2017-11-23 07:55:28,548 [salt.state       ][INFO    ][23709] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 07:55:28.548115
2017-11-23 07:55:28,548 [salt.state       ][INFO    ][23709] 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,549 [salt.state       ][INFO    ][23709] 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,549 [salt.state       ][INFO    ][23709] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 07:55:28.548752 duration_in_ms=0.636
2017-11-23 07:55:28,550 [salt.state       ][INFO    ][23709] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 07:55:28.550293
2017-11-23 07:55:28,551 [salt.state       ][INFO    ][23709] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-23 07:55:28,551 [salt.state       ][INFO    ][23709] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-23 07:55:28,551 [salt.state       ][INFO    ][23709] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 07:55:28.550905 duration_in_ms=0.613
2017-11-23 07:55:28,551 [salt.state       ][INFO    ][23709] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 07:55:28.551069
2017-11-23 07:55:28,551 [salt.state       ][INFO    ][23709] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-23 07:55:28,553 [salt.loaded.int.module.cmdmod][INFO    ][23709] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-11-23 07:55:28,559 [salt.state       ][INFO    ][23709] {'pid': 23789, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-11-23 07:55:28,560 [salt.state       ][INFO    ][23709] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 07:55:28.559759 duration_in_ms=8.689
2017-11-23 07:55:28,561 [salt.state       ][INFO    ][23709] Running state [mine.update] at time 07:55:28.560522
2017-11-23 07:55:28,561 [salt.state       ][INFO    ][23709] Executing state module.wait for mine.update
2017-11-23 07:55:28,561 [salt.state       ][INFO    ][23709] No changes made for mine.update
2017-11-23 07:55:28,561 [salt.state       ][INFO    ][23709] Completed state [mine.update] at time 07:55:28.561091 duration_in_ms=0.57
2017-11-23 07:55:28,561 [salt.state       ][INFO    ][23709] Running state [mine.update] at time 07:55:28.561235
2017-11-23 07:55:28,561 [salt.state       ][INFO    ][23709] Executing state module.mod_watch for mine.update
2017-11-23 07:55:29,077 [salt.state       ][INFO    ][23709] {'ret': True}
2017-11-23 07:55:29,078 [salt.state       ][INFO    ][23709] Completed state [mine.update] at time 07:55:29.077674 duration_in_ms=516.439
2017-11-23 07:55:29,078 [salt.state       ][INFO    ][23709] Running state [ca-certificates] at time 07:55:29.077920
2017-11-23 07:55:29,078 [salt.state       ][INFO    ][23709] Executing state pkg.installed for ca-certificates
2017-11-23 07:55:29,082 [salt.state       ][INFO    ][23709] Package ca-certificates is already installed
2017-11-23 07:55:29,082 [salt.state       ][INFO    ][23709] Completed state [ca-certificates] at time 07:55:29.082296 duration_in_ms=4.376
2017-11-23 07:55:29,083 [salt.state       ][INFO    ][23709] Running state [update-ca-certificates] at time 07:55:29.082908
2017-11-23 07:55:29,083 [salt.state       ][INFO    ][23709] Executing state cmd.wait for update-ca-certificates
2017-11-23 07:55:29,083 [salt.state       ][INFO    ][23709] No changes made for update-ca-certificates
2017-11-23 07:55:29,084 [salt.state       ][INFO    ][23709] Completed state [update-ca-certificates] at time 07:55:29.083475 duration_in_ms=0.567
2017-11-23 07:55:29,084 [salt.state       ][INFO    ][23709] Running state [libvirt-dev] at time 07:55:29.083646
2017-11-23 07:55:29,084 [salt.state       ][INFO    ][23709] Executing state pkg.installed for libvirt-dev
2017-11-23 07:55:29,087 [salt.state       ][INFO    ][23709] Package libvirt-dev is already installed
2017-11-23 07:55:29,088 [salt.state       ][INFO    ][23709] Completed state [libvirt-dev] at time 07:55:29.087614 duration_in_ms=3.968
2017-11-23 07:55:29,088 [salt.state       ][INFO    ][23709] Running state [pkg-config] at time 07:55:29.087802
2017-11-23 07:55:29,088 [salt.state       ][INFO    ][23709] Executing state pkg.installed for pkg-config
2017-11-23 07:55:29,092 [salt.state       ][INFO    ][23709] Package pkg-config is already installed
2017-11-23 07:55:29,092 [salt.state       ][INFO    ][23709] Completed state [pkg-config] at time 07:55:29.091908 duration_in_ms=4.105
2017-11-23 07:55:29,092 [salt.state       ][INFO    ][23709] Running state [virtng.init] at time 07:55:29.092083
2017-11-23 07:55:29,092 [salt.state       ][INFO    ][23709] Executing state module.run for virtng.init
2017-11-23 07:55:29,150 [salt.loaded.int.module.cmdmod][INFO    ][23709] Executing command ['git', '--version'] in directory '/root'
2017-11-23 07:55:29,240 [salt.loaded.int.module.cmdmod][INFO    ][23709] Executing command 'virsh list --all --name| grep -E "^mdb02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-23 07:55:29,258 [salt.state       ][INFO    ][23709] unless execution succeeded
2017-11-23 07:55:29,258 [salt.state       ][INFO    ][23709] Completed state [virtng.init] at time 07:55:29.257930 duration_in_ms=165.845
2017-11-23 07:55:29,258 [salt.state       ][INFO    ][23709] Running state [virt.set_autostart] at time 07:55:29.258192
2017-11-23 07:55:29,258 [salt.state       ][INFO    ][23709] Executing state module.run for virt.set_autostart
2017-11-23 07:55:29,261 [salt.loaded.int.module.cmdmod][INFO    ][23709] Executing command 'virsh list --autostart --name| grep -E "^mdb02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-23 07:55:29,278 [salt.state       ][INFO    ][23709] unless execution succeeded
2017-11-23 07:55:29,278 [salt.state       ][INFO    ][23709] Completed state [virt.set_autostart] at time 07:55:29.277816 duration_in_ms=19.623
2017-11-23 07:55:29,278 [salt.state       ][INFO    ][23709] Running state [virtng.init] at time 07:55:29.278050
2017-11-23 07:55:29,278 [salt.state       ][INFO    ][23709] Executing state module.run for virtng.init
2017-11-23 07:55:29,281 [salt.loaded.int.module.cmdmod][INFO    ][23709] Executing command 'virsh list --all --name| grep -E "^dbs02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-23 07:55:29,296 [salt.state       ][INFO    ][23709] unless execution succeeded
2017-11-23 07:55:29,296 [salt.state       ][INFO    ][23709] Completed state [virtng.init] at time 07:55:29.295763 duration_in_ms=17.713
2017-11-23 07:55:29,296 [salt.state       ][INFO    ][23709] Running state [virt.set_autostart] at time 07:55:29.295992
2017-11-23 07:55:29,296 [salt.state       ][INFO    ][23709] Executing state module.run for virt.set_autostart
2017-11-23 07:55:29,299 [salt.loaded.int.module.cmdmod][INFO    ][23709] Executing command 'virsh list --autostart --name| grep -E "^dbs02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-23 07:55:29,314 [salt.state       ][INFO    ][23709] unless execution succeeded
2017-11-23 07:55:29,314 [salt.state       ][INFO    ][23709] Completed state [virt.set_autostart] at time 07:55:29.313805 duration_in_ms=17.813
2017-11-23 07:55:29,314 [salt.state       ][INFO    ][23709] Running state [virtng.init] at time 07:55:29.314044
2017-11-23 07:55:29,314 [salt.state       ][INFO    ][23709] Executing state module.run for virtng.init
2017-11-23 07:55:29,317 [salt.loaded.int.module.cmdmod][INFO    ][23709] Executing command 'virsh list --all --name| grep -E "^ctl02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-23 07:55:29,332 [salt.state       ][INFO    ][23709] unless execution succeeded
2017-11-23 07:55:29,332 [salt.state       ][INFO    ][23709] Completed state [virtng.init] at time 07:55:29.331733 duration_in_ms=17.688
2017-11-23 07:55:29,332 [salt.state       ][INFO    ][23709] Running state [virt.set_autostart] at time 07:55:29.331964
2017-11-23 07:55:29,332 [salt.state       ][INFO    ][23709] Executing state module.run for virt.set_autostart
2017-11-23 07:55:29,335 [salt.loaded.int.module.cmdmod][INFO    ][23709] Executing command 'virsh list --autostart --name| grep -E "^ctl02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-23 07:55:29,350 [salt.state       ][INFO    ][23709] unless execution succeeded
2017-11-23 07:55:29,350 [salt.state       ][INFO    ][23709] Completed state [virt.set_autostart] at time 07:55:29.349974 duration_in_ms=18.009
2017-11-23 07:55:29,350 [salt.state       ][INFO    ][23709] Running state [virtng.init] at time 07:55:29.350217
2017-11-23 07:55:29,350 [salt.state       ][INFO    ][23709] Executing state module.run for virtng.init
2017-11-23 07:55:29,353 [salt.loaded.int.module.cmdmod][INFO    ][23709] Executing command 'virsh list --all --name| grep -E "^msg02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-23 07:55:29,368 [salt.state       ][INFO    ][23709] unless execution succeeded
2017-11-23 07:55:29,369 [salt.state       ][INFO    ][23709] Completed state [virtng.init] at time 07:55:29.368545 duration_in_ms=18.328
2017-11-23 07:55:29,369 [salt.state       ][INFO    ][23709] Running state [virt.set_autostart] at time 07:55:29.368770
2017-11-23 07:55:29,369 [salt.state       ][INFO    ][23709] Executing state module.run for virt.set_autostart
2017-11-23 07:55:29,371 [salt.loaded.int.module.cmdmod][INFO    ][23709] Executing command 'virsh list --autostart --name| grep -E "^msg02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-23 07:55:29,384 [salt.state       ][INFO    ][23709] unless execution succeeded
2017-11-23 07:55:29,385 [salt.state       ][INFO    ][23709] Completed state [virt.set_autostart] at time 07:55:29.384658 duration_in_ms=15.887
2017-11-23 07:55:29,387 [salt.minion      ][INFO    ][23709] Returning information for job: 20171123075525078109
2017-11-23 07:55:57,183 [salt.minion      ][INFO    ][23545] User sudo_ubuntu Executing command state.sls with jid 20171123075557173246
2017-11-23 07:55:57,193 [salt.minion      ][INFO    ][23836] Starting a new job with PID 23836
2017-11-23 07:55:59,549 [salt.state       ][INFO    ][23836] Loading fresh modules for state activity
2017-11-23 07:55:59,578 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-11-23 07:55:59,596 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-11-23 07:55:59,657 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-23 07:55:59,732 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-11-23 07:55:59,750 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-11-23 07:55:59,777 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-23 07:55:59,848 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-23 07:55:59,867 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-23 07:55:59,923 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-23 07:55:59,942 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-23 07:55:59,957 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-23 07:55:59,974 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-23 07:55:59,983 [salt.loaded.int.module.cmdmod][INFO    ][23836] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-23 07:56:00,006 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-23 07:56:00,024 [py.warnings      ][WARNING ][23836] /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,025 [salt.loaded.int.module.cmdmod][INFO    ][23836] Executing command 'salt-minion --version' in directory '/root'
2017-11-23 07:56:00,282 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-23 07:56:00,301 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-23 07:56:00,314 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-23 07:56:00,327 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-23 07:56:00,373 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-11-23 07:56:00,388 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-11-23 07:56:00,418 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-23 07:56:00,461 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-23 07:56:00,535 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-11-23 07:56:00,557 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-23 07:56:00,623 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-23 07:56:00,645 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-23 07:56:00,702 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-23 07:56:00,722 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-23 07:56:00,736 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-23 07:56:00,753 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-23 07:56:00,761 [salt.loaded.int.module.cmdmod][INFO    ][23836] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-23 07:56:00,783 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-23 07:56:00,801 [salt.loaded.int.module.cmdmod][INFO    ][23836] Executing command 'salt-minion --version' in directory '/root'
2017-11-23 07:56:01,062 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-23 07:56:01,082 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-23 07:56:01,094 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-23 07:56:01,106 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-23 07:56:01,149 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-11-23 07:56:01,166 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-11-23 07:56:01,195 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-23 07:56:01,228 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-23 07:56:01,310 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-11-23 07:56:01,382 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-23 07:56:01,745 [salt.state       ][INFO    ][23836] Running state [salt-minion] at time 07:56:01.744583
2017-11-23 07:56:01,745 [salt.state       ][INFO    ][23836] Executing state pkg.installed for salt-minion
2017-11-23 07:56:01,745 [salt.loaded.int.module.cmdmod][INFO    ][23836] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-23 07:56:02,025 [salt.state       ][INFO    ][23836] Package salt-minion is already installed
2017-11-23 07:56:02,025 [salt.state       ][INFO    ][23836] Completed state [salt-minion] at time 07:56:02.024907 duration_in_ms=280.325
2017-11-23 07:56:02,025 [salt.state       ][INFO    ][23836] Running state [salt_minion_dependency_packages] at time 07:56:02.025198
2017-11-23 07:56:02,025 [salt.state       ][INFO    ][23836] Executing state pkg.installed for salt_minion_dependency_packages
2017-11-23 07:56:02,029 [salt.state       ][INFO    ][23836] All specified packages are already installed
2017-11-23 07:56:02,029 [salt.state       ][INFO    ][23836] Completed state [salt_minion_dependency_packages] at time 07:56:02.029378 duration_in_ms=4.18
2017-11-23 07:56:02,031 [salt.state       ][INFO    ][23836] Running state [/etc/salt/minion.d/minion.conf] at time 07:56:02.031062
2017-11-23 07:56:02,031 [salt.state       ][INFO    ][23836] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-11-23 07:56:02,059 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-11-23 07:56:02,121 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-23 07:56:02,180 [salt.fileclient  ][INFO    ][23836] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-23 07:56:02,229 [salt.state       ][INFO    ][23836] File /etc/salt/minion.d/minion.conf is in the correct state
2017-11-23 07:56:02,229 [salt.state       ][INFO    ][23836] Completed state [/etc/salt/minion.d/minion.conf] at time 07:56:02.229319 duration_in_ms=198.257
2017-11-23 07:56:02,230 [salt.state       ][INFO    ][23836] Running state [/etc/salt/minion.d/_virt.conf] at time 07:56:02.229737
2017-11-23 07:56:02,230 [salt.state       ][INFO    ][23836] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-11-23 07:56:02,231 [salt.state       ][INFO    ][23836] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-11-23 07:56:02,231 [salt.state       ][INFO    ][23836] Completed state [/etc/salt/minion.d/_virt.conf] at time 07:56:02.230774 duration_in_ms=1.037
2017-11-23 07:56:02,232 [salt.state       ][INFO    ][23836] Running state [salt-minion] at time 07:56:02.232456
2017-11-23 07:56:02,233 [salt.state       ][INFO    ][23836] Executing state service.running for salt-minion
2017-11-23 07:56:02,233 [salt.loaded.int.module.cmdmod][INFO    ][23836] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-23 07:56:02,247 [salt.loaded.int.module.cmdmod][INFO    ][23836] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-11-23 07:56:02,254 [salt.loaded.int.module.cmdmod][INFO    ][23836] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-23 07:56:02,260 [salt.state       ][INFO    ][23836] The service salt-minion is already running
2017-11-23 07:56:02,260 [salt.state       ][INFO    ][23836] Completed state [salt-minion] at time 07:56:02.260019 duration_in_ms=27.562
2017-11-23 07:56:02,262 [salt.state       ][INFO    ][23836] Running state [/etc/salt/grains.d] at time 07:56:02.261576
2017-11-23 07:56:02,262 [salt.state       ][INFO    ][23836] Executing state file.directory for /etc/salt/grains.d
2017-11-23 07:56:02,262 [salt.state       ][INFO    ][23836] Directory /etc/salt/grains.d is in the correct state
2017-11-23 07:56:02,263 [salt.state       ][INFO    ][23836] Completed state [/etc/salt/grains.d] at time 07:56:02.262568 duration_in_ms=0.993
2017-11-23 07:56:02,263 [salt.state       ][INFO    ][23836] Running state [/etc/salt/grains] at time 07:56:02.263113
2017-11-23 07:56:02,263 [salt.state       ][INFO    ][23836] Executing state file.managed for /etc/salt/grains
2017-11-23 07:56:02,264 [salt.state       ][INFO    ][23836] File /etc/salt/grains exists with proper permissions. No changes made.
2017-11-23 07:56:02,264 [salt.state       ][INFO    ][23836] Completed state [/etc/salt/grains] at time 07:56:02.263858 duration_in_ms=0.744
2017-11-23 07:56:02,264 [salt.state       ][INFO    ][23836] Running state [/etc/salt/grains.d/placeholder] at time 07:56:02.264245
2017-11-23 07:56:02,264 [salt.state       ][INFO    ][23836] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-11-23 07:56:02,265 [salt.state       ][INFO    ][23836] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-11-23 07:56:02,265 [salt.state       ][INFO    ][23836] Completed state [/etc/salt/grains.d/placeholder] at time 07:56:02.264952 duration_in_ms=0.708
2017-11-23 07:56:02,265 [salt.state       ][INFO    ][23836] Running state [/etc/salt/grains.d/sphinx] at time 07:56:02.265297
2017-11-23 07:56:02,266 [salt.state       ][INFO    ][23836] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-11-23 07:56:02,266 [salt.state       ][INFO    ][23836] File /etc/salt/grains.d/sphinx is in the correct state
2017-11-23 07:56:02,266 [salt.state       ][INFO    ][23836] Completed state [/etc/salt/grains.d/sphinx] at time 07:56:02.266377 duration_in_ms=1.08
2017-11-23 07:56:02,267 [salt.state       ][INFO    ][23836] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 07:56:02.267101
2017-11-23 07:56:02,267 [salt.state       ][INFO    ][23836] 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,268 [salt.state       ][INFO    ][23836] 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,268 [salt.state       ][INFO    ][23836] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 07:56:02.267669 duration_in_ms=0.568
2017-11-23 07:56:02,268 [salt.state       ][INFO    ][23836] Running state [/etc/salt/grains.d/dns_records] at time 07:56:02.268021
2017-11-23 07:56:02,268 [salt.state       ][INFO    ][23836] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-11-23 07:56:02,269 [salt.state       ][INFO    ][23836] File /etc/salt/grains.d/dns_records is in the correct state
2017-11-23 07:56:02,269 [salt.state       ][INFO    ][23836] Completed state [/etc/salt/grains.d/dns_records] at time 07:56:02.269085 duration_in_ms=1.065
2017-11-23 07:56:02,270 [salt.state       ][INFO    ][23836] 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.269816
2017-11-23 07:56:02,270 [salt.state       ][INFO    ][23836] 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,270 [salt.state       ][INFO    ][23836] 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,270 [salt.state       ][INFO    ][23836] 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.270379 duration_in_ms=0.564
2017-11-23 07:56:02,271 [salt.state       ][INFO    ][23836] Running state [/etc/salt/grains.d/salt] at time 07:56:02.270725
2017-11-23 07:56:02,271 [salt.state       ][INFO    ][23836] Executing state file.managed for /etc/salt/grains.d/salt
2017-11-23 07:56:02,272 [salt.state       ][INFO    ][23836] File /etc/salt/grains.d/salt is in the correct state
2017-11-23 07:56:02,272 [salt.state       ][INFO    ][23836] Completed state [/etc/salt/grains.d/salt] at time 07:56:02.271719 duration_in_ms=0.994
2017-11-23 07:56:02,273 [salt.state       ][INFO    ][23836] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 07:56:02.272488
2017-11-23 07:56:02,273 [salt.state       ][INFO    ][23836] 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,273 [salt.state       ][INFO    ][23836] 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,273 [salt.state       ][INFO    ][23836] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 07:56:02.273067 duration_in_ms=0.579
2017-11-23 07:56:02,275 [salt.state       ][INFO    ][23836] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 07:56:02.274621
2017-11-23 07:56:02,275 [salt.state       ][INFO    ][23836] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-23 07:56:02,275 [salt.state       ][INFO    ][23836] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-23 07:56:02,275 [salt.state       ][INFO    ][23836] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 07:56:02.275201 duration_in_ms=0.58
2017-11-23 07:56:02,276 [salt.state       ][INFO    ][23836] Running state [mine.update] at time 07:56:02.275730
2017-11-23 07:56:02,276 [salt.state       ][INFO    ][23836] Executing state module.wait for mine.update
2017-11-23 07:56:02,276 [salt.state       ][INFO    ][23836] No changes made for mine.update
2017-11-23 07:56:02,276 [salt.state       ][INFO    ][23836] Completed state [mine.update] at time 07:56:02.276291 duration_in_ms=0.562
2017-11-23 07:56:02,277 [salt.state       ][INFO    ][23836] Running state [ca-certificates] at time 07:56:02.276483
2017-11-23 07:56:02,277 [salt.state       ][INFO    ][23836] Executing state pkg.installed for ca-certificates
2017-11-23 07:56:02,281 [salt.state       ][INFO    ][23836] Package ca-certificates is already installed
2017-11-23 07:56:02,281 [salt.state       ][INFO    ][23836] Completed state [ca-certificates] at time 07:56:02.280866 duration_in_ms=4.382
2017-11-23 07:56:02,281 [salt.state       ][INFO    ][23836] Running state [update-ca-certificates] at time 07:56:02.281424
2017-11-23 07:56:02,282 [salt.state       ][INFO    ][23836] Executing state cmd.wait for update-ca-certificates
2017-11-23 07:56:02,282 [salt.state       ][INFO    ][23836] No changes made for update-ca-certificates
2017-11-23 07:56:02,282 [salt.state       ][INFO    ][23836] Completed state [update-ca-certificates] at time 07:56:02.281969 duration_in_ms=0.544
2017-11-23 07:56:02,282 [salt.state       ][INFO    ][23836] Running state [libvirt-dev] at time 07:56:02.282138
2017-11-23 07:56:02,282 [salt.state       ][INFO    ][23836] Executing state pkg.installed for libvirt-dev
2017-11-23 07:56:02,286 [salt.state       ][INFO    ][23836] Package libvirt-dev is already installed
2017-11-23 07:56:02,286 [salt.state       ][INFO    ][23836] Completed state [libvirt-dev] at time 07:56:02.286321 duration_in_ms=4.183
2017-11-23 07:56:02,287 [salt.state       ][INFO    ][23836] Running state [pkg-config] at time 07:56:02.286495
2017-11-23 07:56:02,287 [salt.state       ][INFO    ][23836] Executing state pkg.installed for pkg-config
2017-11-23 07:56:02,290 [salt.state       ][INFO    ][23836] Package pkg-config is already installed
2017-11-23 07:56:02,291 [salt.state       ][INFO    ][23836] Completed state [pkg-config] at time 07:56:02.290571 duration_in_ms=4.075
2017-11-23 07:56:02,291 [salt.state       ][INFO    ][23836] Running state [virtng.init] at time 07:56:02.290749
2017-11-23 07:56:02,291 [salt.state       ][INFO    ][23836] Executing state module.run for virtng.init
2017-11-23 07:56:02,337 [salt.loaded.int.module.cmdmod][INFO    ][23836] Executing command ['git', '--version'] in directory '/root'
2017-11-23 07:56:02,415 [salt.loaded.int.module.cmdmod][INFO    ][23836] Executing command 'virsh list --all --name| grep -E "^mdb02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-23 07:56:02,432 [salt.state       ][INFO    ][23836] unless execution succeeded
2017-11-23 07:56:02,432 [salt.state       ][INFO    ][23836] Completed state [virtng.init] at time 07:56:02.431968 duration_in_ms=141.218
2017-11-23 07:56:02,432 [salt.state       ][INFO    ][23836] Running state [virt.set_autostart] at time 07:56:02.432286
2017-11-23 07:56:02,433 [salt.state       ][INFO    ][23836] Executing state module.run for virt.set_autostart
2017-11-23 07:56:02,435 [salt.loaded.int.module.cmdmod][INFO    ][23836] Executing command 'virsh list --autostart --name| grep -E "^mdb02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-23 07:56:02,451 [salt.state       ][INFO    ][23836] unless execution succeeded
2017-11-23 07:56:02,451 [salt.state       ][INFO    ][23836] Completed state [virt.set_autostart] at time 07:56:02.451372 duration_in_ms=19.075
2017-11-23 07:56:02,452 [salt.state       ][INFO    ][23836] Running state [virtng.init] at time 07:56:02.451602
2017-11-23 07:56:02,452 [salt.state       ][INFO    ][23836] Executing state module.run for virtng.init
2017-11-23 07:56:02,454 [salt.loaded.int.module.cmdmod][INFO    ][23836] Executing command 'virsh list --all --name| grep -E "^dbs02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-23 07:56:02,470 [salt.state       ][INFO    ][23836] unless execution succeeded
2017-11-23 07:56:02,470 [salt.state       ][INFO    ][23836] Completed state [virtng.init] at time 07:56:02.469849 duration_in_ms=18.247
2017-11-23 07:56:02,470 [salt.state       ][INFO    ][23836] Running state [virt.set_autostart] at time 07:56:02.470103
2017-11-23 07:56:02,470 [salt.state       ][INFO    ][23836] Executing state module.run for virt.set_autostart
2017-11-23 07:56:02,473 [salt.loaded.int.module.cmdmod][INFO    ][23836] Executing command 'virsh list --autostart --name| grep -E "^dbs02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-23 07:56:02,487 [salt.state       ][INFO    ][23836] unless execution succeeded
2017-11-23 07:56:02,487 [salt.state       ][INFO    ][23836] Completed state [virt.set_autostart] at time 07:56:02.487260 duration_in_ms=17.157
2017-11-23 07:56:02,488 [salt.state       ][INFO    ][23836] Running state [virtng.init] at time 07:56:02.487479
2017-11-23 07:56:02,488 [salt.state       ][INFO    ][23836] Executing state module.run for virtng.init
2017-11-23 07:56:02,490 [salt.loaded.int.module.cmdmod][INFO    ][23836] Executing command 'virsh list --all --name| grep -E "^ctl02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-23 07:56:02,505 [salt.state       ][INFO    ][23836] unless execution succeeded
2017-11-23 07:56:02,506 [salt.state       ][INFO    ][23836] Completed state [virtng.init] at time 07:56:02.505708 duration_in_ms=18.229
2017-11-23 07:56:02,506 [salt.state       ][INFO    ][23836] Running state [virt.set_autostart] at time 07:56:02.505964
2017-11-23 07:56:02,506 [salt.state       ][INFO    ][23836] Executing state module.run for virt.set_autostart
2017-11-23 07:56:02,509 [salt.loaded.int.module.cmdmod][INFO    ][23836] Executing command 'virsh list --autostart --name| grep -E "^ctl02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-23 07:56:02,523 [salt.state       ][INFO    ][23836] unless execution succeeded
2017-11-23 07:56:02,523 [salt.state       ][INFO    ][23836] Completed state [virt.set_autostart] at time 07:56:02.523283 duration_in_ms=17.319
2017-11-23 07:56:02,524 [salt.state       ][INFO    ][23836] Running state [virtng.init] at time 07:56:02.523502
2017-11-23 07:56:02,524 [salt.state       ][INFO    ][23836] Executing state module.run for virtng.init
2017-11-23 07:56:02,526 [salt.loaded.int.module.cmdmod][INFO    ][23836] Executing command 'virsh list --all --name| grep -E "^msg02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-23 07:56:02,541 [salt.state       ][INFO    ][23836] unless execution succeeded
2017-11-23 07:56:02,541 [salt.state       ][INFO    ][23836] Completed state [virtng.init] at time 07:56:02.541060 duration_in_ms=17.557
2017-11-23 07:56:02,541 [salt.state       ][INFO    ][23836] Running state [virt.set_autostart] at time 07:56:02.541315
2017-11-23 07:56:02,542 [salt.state       ][INFO    ][23836] Executing state module.run for virt.set_autostart
2017-11-23 07:56:02,544 [salt.loaded.int.module.cmdmod][INFO    ][23836] Executing command 'virsh list --autostart --name| grep -E "^msg02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-23 07:56:02,558 [salt.state       ][INFO    ][23836] unless execution succeeded
2017-11-23 07:56:02,558 [salt.state       ][INFO    ][23836] Completed state [virt.set_autostart] at time 07:56:02.558129 duration_in_ms=16.814
2017-11-23 07:56:02,561 [salt.minion      ][INFO    ][23836] Returning information for job: 20171123075557173246
2017-11-23 07:56:23,608 [salt.minion      ][INFO    ][23545] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171123075623594649
2017-11-23 07:56:23,622 [salt.minion      ][INFO    ][23924] Starting a new job with PID 23924
2017-11-23 07:56:28,287 [salt.state       ][INFO    ][23924] Loading fresh modules for state activity
2017-11-23 07:56:28,313 [salt.state       ][ERROR   ][23924] No contents found in top file
2017-11-23 07:56:28,314 [salt.utils.extmods][INFO    ][23924] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-11-23 07:56:28,317 [salt.utils.extmods][INFO    ][23924] Syncing beacons for environment 'base'
2017-11-23 07:56:28,317 [salt.utils.extmods][INFO    ][23924] Loading cache from salt://_beacons, for base)
2017-11-23 07:56:28,318 [salt.fileclient  ][INFO    ][23924] Caching directory '_beacons/' for environment 'base'
2017-11-23 07:56:28,361 [salt.utils.extmods][INFO    ][23924] Syncing modules for environment 'base'
2017-11-23 07:56:28,361 [salt.utils.extmods][INFO    ][23924] Loading cache from salt://_modules, for base)
2017-11-23 07:56:28,361 [salt.fileclient  ][INFO    ][23924] Caching directory '_modules/' for environment 'base'
2017-11-23 07:56:28,419 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-11-23 07:56:28,428 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-11-23 07:56:28,442 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-11-23 07:56:28,535 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-11-23 07:56:28,558 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-11-23 07:56:28,569 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-11-23 07:56:28,587 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-11-23 07:56:28,599 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-11-23 07:56:28,607 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-11-23 07:56:28,617 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-11-23 07:56:28,628 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-11-23 07:56:28,642 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-11-23 07:56:28,654 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-11-23 07:56:28,675 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-11-23 07:56:28,688 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-11-23 07:56:28,699 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-11-23 07:56:28,726 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-11-23 07:56:28,743 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-11-23 07:56:28,755 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-11-23 07:56:28,767 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-11-23 07:56:28,783 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-11-23 07:56:28,797 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-11-23 07:56:28,808 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-11-23 07:56:28,820 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-11-23 07:56:28,833 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-11-23 07:56:28,842 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-11-23 07:56:28,853 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-11-23 07:56:28,862 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-11-23 07:56:28,881 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-11-23 07:56:28,890 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-11-23 07:56:28,900 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-11-23 07:56:28,909 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-11-23 07:56:28,920 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-11-23 07:56:28,924 [salt.utils.extmods][INFO    ][23924] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-11-23 07:56:28,924 [salt.utils.extmods][INFO    ][23924] 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:28,924 [salt.utils.extmods][INFO    ][23924] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-11-23 07:56:28,925 [salt.utils.extmods][INFO    ][23924] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-11-23 07:56:28,925 [salt.utils.extmods][INFO    ][23924] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-11-23 07:56:28,925 [salt.utils.extmods][INFO    ][23924] 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:28,926 [salt.utils.extmods][INFO    ][23924] 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:28,926 [salt.utils.extmods][INFO    ][23924] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-11-23 07:56:28,926 [salt.utils.extmods][INFO    ][23924] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-11-23 07:56:28,926 [salt.utils.extmods][INFO    ][23924] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-11-23 07:56:28,927 [salt.utils.extmods][INFO    ][23924] 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:28,927 [salt.utils.extmods][INFO    ][23924] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-11-23 07:56:28,927 [salt.utils.extmods][INFO    ][23924] 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:28,927 [salt.utils.extmods][INFO    ][23924] 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:28,928 [salt.utils.extmods][INFO    ][23924] 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:28,928 [salt.utils.extmods][INFO    ][23924] 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:28,928 [salt.utils.extmods][INFO    ][23924] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-11-23 07:56:28,928 [salt.utils.extmods][INFO    ][23924] 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:28,929 [salt.utils.extmods][INFO    ][23924] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2017-11-23 07:56:28,929 [salt.utils.extmods][INFO    ][23924] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-11-23 07:56:28,929 [salt.utils.extmods][INFO    ][23924] 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:28,929 [salt.utils.extmods][INFO    ][23924] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-11-23 07:56:28,930 [salt.utils.extmods][INFO    ][23924] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-11-23 07:56:28,930 [salt.utils.extmods][INFO    ][23924] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-11-23 07:56:28,930 [salt.utils.extmods][INFO    ][23924] 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:28,931 [salt.utils.extmods][INFO    ][23924] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-11-23 07:56:28,931 [salt.utils.extmods][INFO    ][23924] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-11-23 07:56:28,931 [salt.utils.extmods][INFO    ][23924] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-11-23 07:56:28,931 [salt.utils.extmods][INFO    ][23924] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-11-23 07:56:28,932 [salt.utils.extmods][INFO    ][23924] 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:28,932 [salt.utils.extmods][INFO    ][23924] 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:28,932 [salt.utils.extmods][INFO    ][23924] 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:28,932 [salt.utils.extmods][INFO    ][23924] 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:28,933 [salt.utils.extmods][INFO    ][23924] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-11-23 07:56:28,933 [salt.utils.extmods][INFO    ][23924] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-11-23 07:56:28,939 [salt.utils.extmods][INFO    ][23924] Syncing states for environment 'base'
2017-11-23 07:56:28,939 [salt.utils.extmods][INFO    ][23924] Loading cache from salt://_states, for base)
2017-11-23 07:56:28,939 [salt.fileclient  ][INFO    ][23924] Caching directory '_states/' for environment 'base'
2017-11-23 07:56:28,972 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-11-23 07:56:28,981 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-11-23 07:56:28,990 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-11-23 07:56:29,000 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-11-23 07:56:29,011 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-11-23 07:56:29,062 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-11-23 07:56:29,141 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-11-23 07:56:29,159 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-11-23 07:56:29,176 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-11-23 07:56:29,190 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-11-23 07:56:29,205 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-11-23 07:56:29,250 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_states/jenkins_globalenvprop.py'
2017-11-23 07:56:29,263 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-11-23 07:56:29,283 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-11-23 07:56:29,303 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-11-23 07:56:29,323 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-11-23 07:56:29,334 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-11-23 07:56:29,344 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-11-23 07:56:29,359 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-11-23 07:56:29,396 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-11-23 07:56:29,421 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-11-23 07:56:29,432 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-11-23 07:56:29,449 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-11-23 07:56:29,460 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-11-23 07:56:29,515 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-11-23 07:56:29,553 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-11-23 07:56:29,564 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-11-23 07:56:29,582 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-11-23 07:56:29,592 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-11-23 07:56:29,615 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-11-23 07:56:29,618 [salt.utils.extmods][INFO    ][23924] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-11-23 07:56:29,619 [salt.utils.extmods][INFO    ][23924] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-11-23 07:56:29,619 [salt.utils.extmods][INFO    ][23924] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-11-23 07:56:29,619 [salt.utils.extmods][INFO    ][23924] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-11-23 07:56:29,620 [salt.utils.extmods][INFO    ][23924] 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:29,620 [salt.utils.extmods][INFO    ][23924] 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:29,620 [salt.utils.extmods][INFO    ][23924] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-11-23 07:56:29,621 [salt.utils.extmods][INFO    ][23924] 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:29,621 [salt.utils.extmods][INFO    ][23924] 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:29,621 [salt.utils.extmods][INFO    ][23924] 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:29,621 [salt.utils.extmods][INFO    ][23924] 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:29,622 [salt.utils.extmods][INFO    ][23924] 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:29,622 [salt.utils.extmods][INFO    ][23924] 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:29,622 [salt.utils.extmods][INFO    ][23924] 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:29,622 [salt.utils.extmods][INFO    ][23924] 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:29,623 [salt.utils.extmods][INFO    ][23924] 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:29,623 [salt.utils.extmods][INFO    ][23924] 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:29,623 [salt.utils.extmods][INFO    ][23924] 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:29,623 [salt.utils.extmods][INFO    ][23924] 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:29,623 [salt.utils.extmods][INFO    ][23924] 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:29,624 [salt.utils.extmods][INFO    ][23924] 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:29,624 [salt.utils.extmods][INFO    ][23924] 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:29,624 [salt.utils.extmods][INFO    ][23924] 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:29,624 [salt.utils.extmods][INFO    ][23924] 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:29,625 [salt.utils.extmods][INFO    ][23924] 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:29,625 [salt.utils.extmods][INFO    ][23924] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-11-23 07:56:29,626 [salt.utils.extmods][INFO    ][23924] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-11-23 07:56:29,626 [salt.utils.extmods][INFO    ][23924] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-11-23 07:56:29,627 [salt.utils.extmods][INFO    ][23924] 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:29,627 [salt.utils.extmods][INFO    ][23924] 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:29,627 [salt.utils.extmods][INFO    ][23924] 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:29,629 [salt.utils.extmods][INFO    ][23924] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-11-23 07:56:29,632 [salt.utils.extmods][INFO    ][23924] Syncing sdb for environment 'base'
2017-11-23 07:56:29,633 [salt.utils.extmods][INFO    ][23924] Loading cache from salt://_sdb, for base)
2017-11-23 07:56:29,633 [salt.fileclient  ][INFO    ][23924] Caching directory '_sdb/' for environment 'base'
2017-11-23 07:56:29,702 [salt.utils.extmods][INFO    ][23924] Syncing grains for environment 'base'
2017-11-23 07:56:29,702 [salt.utils.extmods][INFO    ][23924] Loading cache from salt://_grains, for base)
2017-11-23 07:56:29,702 [salt.fileclient  ][INFO    ][23924] Caching directory '_grains/' for environment 'base'
2017-11-23 07:56:29,768 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-11-23 07:56:29,829 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-11-23 07:56:29,847 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-11-23 07:56:29,879 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-11-23 07:56:29,895 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-11-23 07:56:29,908 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-11-23 07:56:29,924 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-11-23 07:56:29,935 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-11-23 07:56:29,955 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-11-23 07:56:29,963 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-11-23 07:56:29,975 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-11-23 07:56:29,984 [salt.fileclient  ][INFO    ][23924] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-11-23 07:56:29,989 [salt.utils.extmods][INFO    ][23924] 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:29,989 [salt.utils.extmods][INFO    ][23924] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-11-23 07:56:29,989 [salt.utils.extmods][INFO    ][23924] 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:29,989 [salt.utils.extmods][INFO    ][23924] 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:29,989 [salt.utils.extmods][INFO    ][23924] 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:29,990 [salt.utils.extmods][INFO    ][23924] 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:29,990 [salt.utils.extmods][INFO    ][23924] 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:29,990 [salt.utils.extmods][INFO    ][23924] 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:29,990 [salt.utils.extmods][INFO    ][23924] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-11-23 07:56:29,991 [salt.utils.extmods][INFO    ][23924] 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:29,991 [salt.utils.extmods][INFO    ][23924] 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:29,991 [salt.utils.extmods][INFO    ][23924] 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:29,993 [salt.utils.extmods][INFO    ][23924] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-11-23 07:56:29,996 [salt.utils.extmods][INFO    ][23924] Syncing renderers for environment 'base'
2017-11-23 07:56:29,996 [salt.utils.extmods][INFO    ][23924] Loading cache from salt://_renderers, for base)
2017-11-23 07:56:29,996 [salt.fileclient  ][INFO    ][23924] Caching directory '_renderers/' for environment 'base'
2017-11-23 07:56:30,101 [salt.utils.extmods][INFO    ][23924] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-11-23 07:56:30,104 [salt.utils.extmods][INFO    ][23924] Syncing returners for environment 'base'
2017-11-23 07:56:30,104 [salt.utils.extmods][INFO    ][23924] Loading cache from salt://_returners, for base)
2017-11-23 07:56:30,104 [salt.fileclient  ][INFO    ][23924] Caching directory '_returners/' for environment 'base'
2017-11-23 07:56:30,222 [salt.utils.extmods][INFO    ][23924] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-11-23 07:56:30,225 [salt.utils.extmods][INFO    ][23924] Syncing output for environment 'base'
2017-11-23 07:56:30,225 [salt.utils.extmods][INFO    ][23924] Loading cache from salt://_output, for base)
2017-11-23 07:56:30,225 [salt.fileclient  ][INFO    ][23924] Caching directory '_output/' for environment 'base'
2017-11-23 07:56:30,270 [salt.utils.extmods][INFO    ][23924] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-11-23 07:56:30,273 [salt.utils.extmods][INFO    ][23924] Syncing utils for environment 'base'
2017-11-23 07:56:30,273 [salt.utils.extmods][INFO    ][23924] Loading cache from salt://_utils, for base)
2017-11-23 07:56:30,273 [salt.fileclient  ][INFO    ][23924] Caching directory '_utils/' for environment 'base'
2017-11-23 07:56:30,326 [salt.utils.extmods][INFO    ][23924] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-11-23 07:56:30,329 [salt.utils.extmods][INFO    ][23924] Syncing log_handlers for environment 'base'
2017-11-23 07:56:30,329 [salt.utils.extmods][INFO    ][23924] Loading cache from salt://_log_handlers, for base)
2017-11-23 07:56:30,329 [salt.fileclient  ][INFO    ][23924] Caching directory '_log_handlers/' for environment 'base'
2017-11-23 07:56:30,369 [salt.utils.extmods][INFO    ][23924] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-11-23 07:56:30,371 [salt.utils.extmods][INFO    ][23924] Syncing proxy for environment 'base'
2017-11-23 07:56:30,371 [salt.utils.extmods][INFO    ][23924] Loading cache from salt://_proxy, for base)
2017-11-23 07:56:30,372 [salt.fileclient  ][INFO    ][23924] Caching directory '_proxy/' for environment 'base'
2017-11-23 07:56:30,415 [salt.utils.extmods][INFO    ][23924] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-11-23 07:56:30,418 [salt.utils.extmods][INFO    ][23924] Syncing engines for environment 'base'
2017-11-23 07:56:30,418 [salt.utils.extmods][INFO    ][23924] Loading cache from salt://_engines, for base)
2017-11-23 07:56:30,418 [salt.fileclient  ][INFO    ][23924] Caching directory '_engines/' for environment 'base'
2017-11-23 07:56:30,480 [salt.minion      ][INFO    ][23924] Returning information for job: 20171123075623594649
2017-11-23 08:10:04,698 [salt.minion      ][INFO    ][23545] User sudo_ubuntu Executing command test.ping with jid 20171123081004685733
2017-11-23 08:10:04,712 [salt.minion      ][INFO    ][24178] Starting a new job with PID 24178
2017-11-23 08:10:04,753 [salt.minion      ][INFO    ][24178] Returning information for job: 20171123081004685733
2017-11-23 08:11:13,783 [salt.minion      ][INFO    ][23545] User sudo_ubuntu Executing command state.sls with jid 20171123081113768709
2017-11-23 08:11:13,794 [salt.minion      ][INFO    ][24195] Starting a new job with PID 24195
2017-11-23 08:11:16,062 [salt.state       ][INFO    ][24195] Loading fresh modules for state activity
2017-11-23 08:11:16,091 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-11-23 08:11:16,107 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-11-23 08:11:16,132 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-23 08:11:16,463 [salt.state       ][INFO    ][24195] Running state [lsof] at time 08:11:16.462952
2017-11-23 08:11:16,463 [salt.state       ][INFO    ][24195] Executing state pkg.installed for lsof
2017-11-23 08:11:16,464 [salt.loaded.int.module.cmdmod][INFO    ][24195] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-23 08:11:16,720 [salt.state       ][INFO    ][24195] Package lsof is already installed
2017-11-23 08:11:16,720 [salt.state       ][INFO    ][24195] Completed state [lsof] at time 08:11:16.719914 duration_in_ms=256.963
2017-11-23 08:11:16,720 [salt.state       ][INFO    ][24195] Running state [keepalived] at time 08:11:16.720177
2017-11-23 08:11:16,720 [salt.state       ][INFO    ][24195] Executing state pkg.installed for keepalived
2017-11-23 08:11:16,737 [salt.loaded.int.module.cmdmod][INFO    ][24195] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-11-23 08:11:18,625 [salt.loaded.int.module.cmdmod][INFO    ][24195] 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:11:21,270 [salt.loaded.int.module.cmdmod][INFO    ][24195] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-23 08:11:21,298 [salt.state       ][INFO    ][24195] 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:11:21,308 [salt.state       ][INFO    ][24195] Loading fresh modules for state activity
2017-11-23 08:11:21,324 [salt.state       ][INFO    ][24195] Completed state [keepalived] at time 08:11:21.324226 duration_in_ms=4604.048
2017-11-23 08:11:21,326 [salt.state       ][INFO    ][24195] Running state [/etc/keepalived/keepalived.conf] at time 08:11:21.326447
2017-11-23 08:11:21,327 [salt.state       ][INFO    ][24195] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-11-23 08:11:21,350 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-11-23 08:11:21,388 [salt.fileclient  ][INFO    ][24195] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-23 08:11:21,395 [salt.state       ][INFO    ][24195] File changed:
New file
2017-11-23 08:11:21,395 [salt.state       ][INFO    ][24195] Completed state [/etc/keepalived/keepalived.conf] at time 08:11:21.394986 duration_in_ms=68.539
2017-11-23 08:11:21,458 [salt.state       ][INFO    ][24195] Running state [keepalived] at time 08:11:21.458323
2017-11-23 08:11:21,459 [salt.state       ][INFO    ][24195] Executing state service.running for keepalived
2017-11-23 08:11:21,460 [salt.loaded.int.module.cmdmod][INFO    ][24195] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-11-23 08:11:21,470 [salt.loaded.int.module.cmdmod][INFO    ][24195] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-23 08:11:21,477 [salt.loaded.int.module.cmdmod][INFO    ][24195] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-23 08:11:21,485 [salt.loaded.int.module.cmdmod][INFO    ][24195] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-23 08:11:21,493 [salt.loaded.int.module.cmdmod][INFO    ][24195] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-11-23 08:11:21,523 [salt.loaded.int.module.cmdmod][INFO    ][24195] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-23 08:11:21,531 [salt.loaded.int.module.cmdmod][INFO    ][24195] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-23 08:11:21,539 [salt.loaded.int.module.cmdmod][INFO    ][24195] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-23 08:11:21,546 [salt.state       ][INFO    ][24195] {'keepalived': True}
2017-11-23 08:11:21,547 [salt.state       ][INFO    ][24195] Completed state [keepalived] at time 08:11:21.546531 duration_in_ms=88.206
2017-11-23 08:11:21,548 [salt.minion      ][INFO    ][24195] Returning information for job: 20171123081113768709
2017-11-23 08:12:07,549 [salt.minion      ][INFO    ][23545] User sudo_ubuntu Executing command pillar.get with jid 20171123081207538761
2017-11-23 08:12:07,564 [salt.minion      ][INFO    ][25795] Starting a new job with PID 25795
2017-11-23 08:12:07,567 [salt.minion      ][INFO    ][25795] Returning information for job: 20171123081207538761
2017-11-23 08:17:13,220 [salt.minion      ][INFO    ][23545] User sudo_ubuntu Executing command state.sls with jid 20171123081713206602
2017-11-23 08:17:13,232 [salt.minion      ][INFO    ][25888] Starting a new job with PID 25888
2017-11-23 08:17:15,950 [salt.state       ][INFO    ][25888] Loading fresh modules for state activity
2017-11-23 08:17:15,979 [salt.fileclient  ][INFO    ][25888] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-23 08:17:16,008 [salt.fileclient  ][INFO    ][25888] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-23 08:17:16,316 [salt.state       ][INFO    ][25888] Running state [attr] at time 08:17:16.315674
2017-11-23 08:17:16,316 [salt.state       ][INFO    ][25888] Executing state pkg.installed for attr
2017-11-23 08:17:16,316 [salt.loaded.int.module.cmdmod][INFO    ][25888] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-23 08:17:16,583 [salt.loaded.int.module.cmdmod][INFO    ][25888] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-11-23 08:17:18,504 [salt.loaded.int.module.cmdmod][INFO    ][25888] 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:19,847 [salt.loaded.int.module.cmdmod][INFO    ][25888] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-23 08:17:19,875 [salt.state       ][INFO    ][25888] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-11-23 08:17:19,886 [salt.state       ][INFO    ][25888] Loading fresh modules for state activity
2017-11-23 08:17:19,902 [salt.state       ][INFO    ][25888] Completed state [attr] at time 08:17:19.901993 duration_in_ms=3586.319
2017-11-23 08:17:19,908 [salt.state       ][INFO    ][25888] Running state [glusterfs-server] at time 08:17:19.908344
2017-11-23 08:17:19,909 [salt.state       ][INFO    ][25888] Executing state pkg.installed for glusterfs-server
2017-11-23 08:17:20,129 [salt.loaded.int.module.cmdmod][INFO    ][25888] 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,319 [salt.minion      ][INFO    ][23545] User sudo_ubuntu Executing command saltutil.find_job with jid 20171123081723304957
2017-11-23 08:17:23,329 [salt.minion      ][INFO    ][29742] Starting a new job with PID 29742
2017-11-23 08:17:23,342 [salt.minion      ][INFO    ][29742] Returning information for job: 20171123081723304957
2017-11-23 08:17:26,122 [salt.loaded.int.module.cmdmod][INFO    ][25888] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-23 08:17:26,149 [salt.state       ][INFO    ][25888] 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:26,160 [salt.state       ][INFO    ][25888] Loading fresh modules for state activity
2017-11-23 08:17:26,177 [salt.state       ][INFO    ][25888] Completed state [glusterfs-server] at time 08:17:26.176617 duration_in_ms=6268.273
2017-11-23 08:17:26,182 [salt.state       ][INFO    ][25888] Running state [bc] at time 08:17:26.181983
2017-11-23 08:17:26,182 [salt.state       ][INFO    ][25888] Executing state pkg.installed for bc
2017-11-23 08:17:26,478 [salt.loaded.int.module.cmdmod][INFO    ][25888] 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,896 [salt.loaded.int.module.cmdmod][INFO    ][25888] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-23 08:17:27,926 [salt.state       ][INFO    ][25888] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-11-23 08:17:27,936 [salt.state       ][INFO    ][25888] Loading fresh modules for state activity
2017-11-23 08:17:27,953 [salt.state       ][INFO    ][25888] Completed state [bc] at time 08:17:27.952763 duration_in_ms=1770.779
2017-11-23 08:17:28,023 [salt.state       ][INFO    ][25888] Running state [glusterfs-server] at time 08:17:28.023041
2017-11-23 08:17:28,023 [salt.state       ][INFO    ][25888] Executing state service.running for glusterfs-server
2017-11-23 08:17:28,025 [salt.loaded.int.module.cmdmod][INFO    ][25888] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-23 08:17:28,034 [salt.loaded.int.module.cmdmod][INFO    ][25888] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-23 08:17:28,042 [salt.loaded.int.module.cmdmod][INFO    ][25888] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-23 08:17:28,051 [salt.state       ][INFO    ][25888] The service glusterfs-server is already running
2017-11-23 08:17:28,051 [salt.state       ][INFO    ][25888] Completed state [glusterfs-server] at time 08:17:28.051111 duration_in_ms=28.059
2017-11-23 08:17:28,053 [salt.state       ][INFO    ][25888] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 08:17:28.052623
2017-11-23 08:17:28,053 [salt.state       ][INFO    ][25888] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-23 08:17:28,058 [salt.state       ][INFO    ][25888] File changed:
New file
2017-11-23 08:17:28,058 [salt.state       ][INFO    ][25888] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 08:17:28.057792 duration_in_ms=5.168
2017-11-23 08:17:28,058 [salt.state       ][INFO    ][25888] Running state [/srv/glusterfs/glance] at time 08:17:28.057990
2017-11-23 08:17:28,058 [salt.state       ][INFO    ][25888] Executing state file.directory for /srv/glusterfs/glance
2017-11-23 08:17:28,059 [salt.state       ][INFO    ][25888] {'/srv/glusterfs/glance': 'New Dir'}
2017-11-23 08:17:28,059 [salt.state       ][INFO    ][25888] Completed state [/srv/glusterfs/glance] at time 08:17:28.059022 duration_in_ms=1.032
2017-11-23 08:17:28,059 [salt.state       ][INFO    ][25888] Running state [/srv/glusterfs/keystone-keys] at time 08:17:28.059200
2017-11-23 08:17:28,059 [salt.state       ][INFO    ][25888] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-23 08:17:28,060 [salt.state       ][INFO    ][25888] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-11-23 08:17:28,060 [salt.state       ][INFO    ][25888] Completed state [/srv/glusterfs/keystone-keys] at time 08:17:28.060021 duration_in_ms=0.821
2017-11-23 08:17:28,060 [salt.state       ][INFO    ][25888] Running state [/srv/glusterfs/nova_instances] at time 08:17:28.060219
2017-11-23 08:17:28,060 [salt.state       ][INFO    ][25888] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-23 08:17:28,061 [salt.state       ][INFO    ][25888] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-11-23 08:17:28,061 [salt.state       ][INFO    ][25888] Completed state [/srv/glusterfs/nova_instances] at time 08:17:28.061051 duration_in_ms=0.833
2017-11-23 08:17:28,061 [salt.state       ][INFO    ][25888] Running state [/srv/glusterfs/keystone-credential-keys] at time 08:17:28.061238
2017-11-23 08:17:28,061 [salt.state       ][INFO    ][25888] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-23 08:17:28,062 [salt.state       ][INFO    ][25888] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-11-23 08:17:28,062 [salt.state       ][INFO    ][25888] Completed state [/srv/glusterfs/keystone-credential-keys] at time 08:17:28.062044 duration_in_ms=0.806
2017-11-23 08:17:28,063 [salt.minion      ][INFO    ][25888] Returning information for job: 20171123081713206602
2017-11-23 08:17:29,129 [salt.minion      ][INFO    ][23545] User sudo_ubuntu Executing command test.ping with jid 20171123081729117029
2017-11-23 08:17:29,139 [salt.minion      ][INFO    ][30653] Starting a new job with PID 30653
2017-11-23 08:17:29,174 [salt.minion      ][INFO    ][30653] Returning information for job: 20171123081729117029
2017-11-23 08:17:29,316 [salt.minion      ][INFO    ][23545] User sudo_ubuntu Executing command state.sls with jid 20171123081729296836
2017-11-23 08:17:29,327 [salt.minion      ][INFO    ][30658] Starting a new job with PID 30658
2017-11-23 08:17:29,948 [salt.state       ][INFO    ][30658] Loading fresh modules for state activity
2017-11-23 08:17:29,978 [salt.fileclient  ][INFO    ][30658] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-11-23 08:17:30,019 [salt.fileclient  ][INFO    ][30658] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-23 08:17:30,101 [salt.fileclient  ][INFO    ][30658] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-23 08:17:30,124 [salt.fileclient  ][INFO    ][30658] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-23 08:17:30,426 [salt.state       ][INFO    ][30658] Running state [attr] at time 08:17:30.425562
2017-11-23 08:17:30,426 [salt.state       ][INFO    ][30658] Executing state pkg.installed for attr
2017-11-23 08:17:30,426 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-23 08:17:30,680 [salt.state       ][INFO    ][30658] Package attr is already installed
2017-11-23 08:17:30,680 [salt.state       ][INFO    ][30658] Completed state [attr] at time 08:17:30.680326 duration_in_ms=254.764
2017-11-23 08:17:30,681 [salt.state       ][INFO    ][30658] Running state [glusterfs-server] at time 08:17:30.680592
2017-11-23 08:17:30,681 [salt.state       ][INFO    ][30658] Executing state pkg.installed for glusterfs-server
2017-11-23 08:17:30,685 [salt.state       ][INFO    ][30658] Package glusterfs-server is already installed
2017-11-23 08:17:30,685 [salt.state       ][INFO    ][30658] Completed state [glusterfs-server] at time 08:17:30.684666 duration_in_ms=4.075
2017-11-23 08:17:30,685 [salt.state       ][INFO    ][30658] Running state [bc] at time 08:17:30.684863
2017-11-23 08:17:30,685 [salt.state       ][INFO    ][30658] Executing state pkg.installed for bc
2017-11-23 08:17:30,689 [salt.state       ][INFO    ][30658] Package bc is already installed
2017-11-23 08:17:30,689 [salt.state       ][INFO    ][30658] Completed state [bc] at time 08:17:30.688785 duration_in_ms=3.922
2017-11-23 08:17:30,690 [salt.state       ][INFO    ][30658] Running state [glusterfs-server] at time 08:17:30.689770
2017-11-23 08:17:30,690 [salt.state       ][INFO    ][30658] Executing state service.running for glusterfs-server
2017-11-23 08:17:30,690 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-23 08:17:30,700 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-11-23 08:17:30,748 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-23 08:17:30,760 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-23 08:17:30,766 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-23 08:17:30,773 [salt.state       ][INFO    ][30658] The service glusterfs-server is already running
2017-11-23 08:17:30,773 [salt.state       ][INFO    ][30658] Completed state [glusterfs-server] at time 08:17:30.772965 duration_in_ms=83.195
2017-11-23 08:17:30,774 [salt.state       ][INFO    ][30658] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 08:17:30.774410
2017-11-23 08:17:30,775 [salt.state       ][INFO    ][30658] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-23 08:17:30,777 [salt.state       ][INFO    ][30658] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-23 08:17:30,777 [salt.state       ][INFO    ][30658] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 08:17:30.776731 duration_in_ms=2.321
2017-11-23 08:17:30,777 [salt.state       ][INFO    ][30658] Running state [/srv/glusterfs/glance] at time 08:17:30.776910
2017-11-23 08:17:30,777 [salt.state       ][INFO    ][30658] Executing state file.directory for /srv/glusterfs/glance
2017-11-23 08:17:30,777 [salt.state       ][INFO    ][30658] Directory /srv/glusterfs/glance is in the correct state
2017-11-23 08:17:30,778 [salt.state       ][INFO    ][30658] Completed state [/srv/glusterfs/glance] at time 08:17:30.777582 duration_in_ms=0.672
2017-11-23 08:17:30,778 [salt.state       ][INFO    ][30658] Running state [/srv/glusterfs/keystone-keys] at time 08:17:30.777747
2017-11-23 08:17:30,778 [salt.state       ][INFO    ][30658] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-23 08:17:30,778 [salt.state       ][INFO    ][30658] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-23 08:17:30,778 [salt.state       ][INFO    ][30658] Completed state [/srv/glusterfs/keystone-keys] at time 08:17:30.778376 duration_in_ms=0.63
2017-11-23 08:17:30,779 [salt.state       ][INFO    ][30658] Running state [/srv/glusterfs/nova_instances] at time 08:17:30.778534
2017-11-23 08:17:30,779 [salt.state       ][INFO    ][30658] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-23 08:17:30,779 [salt.state       ][INFO    ][30658] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-23 08:17:30,779 [salt.state       ][INFO    ][30658] Completed state [/srv/glusterfs/nova_instances] at time 08:17:30.779166 duration_in_ms=0.632
2017-11-23 08:17:30,779 [salt.state       ][INFO    ][30658] Running state [/srv/glusterfs/keystone-credential-keys] at time 08:17:30.779322
2017-11-23 08:17:30,779 [salt.state       ][INFO    ][30658] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-23 08:17:30,780 [salt.state       ][INFO    ][30658] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-23 08:17:30,780 [salt.state       ][INFO    ][30658] Completed state [/srv/glusterfs/keystone-credential-keys] at time 08:17:30.779947 duration_in_ms=0.625
2017-11-23 08:17:30,839 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command ['git', '--version'] in directory '/root'
2017-11-23 08:17:30,924 [salt.state       ][INFO    ][30658] Running state [sleep 5] at time 08:17:30.923782
2017-11-23 08:17:30,924 [salt.state       ][INFO    ][30658] Executing state cmd.wait for sleep 5
2017-11-23 08:17:30,924 [salt.state       ][INFO    ][30658] No changes made for sleep 5
2017-11-23 08:17:30,925 [salt.state       ][INFO    ][30658] Completed state [sleep 5] at time 08:17:30.924550 duration_in_ms=0.769
2017-11-23 08:17:30,925 [salt.state       ][INFO    ][30658] Running state [192.168.10.143] at time 08:17:30.925049
2017-11-23 08:17:30,925 [salt.state       ][INFO    ][30658] Executing state glusterfs.peered for 192.168.10.143
2017-11-23 08:17:30,926 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:30,934 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:30,984 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:30,991 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:31,051 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:31,060 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:31,112 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:31,120 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:31,169 [salt.state       ][INFO    ][30658] {'new': {'192.168.10.143': []}, 'old': None}
2017-11-23 08:17:31,170 [salt.state       ][INFO    ][30658] Completed state [192.168.10.143] at time 08:17:31.169496 duration_in_ms=244.445
2017-11-23 08:17:31,173 [salt.state       ][INFO    ][30658] Running state [192.168.10.142] at time 08:17:31.172602
2017-11-23 08:17:31,173 [salt.state       ][INFO    ][30658] Executing state glusterfs.peered for 192.168.10.142
2017-11-23 08:17:31,173 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:31,181 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:31,231 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:31,238 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:31,290 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:31,298 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:31,349 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:31,357 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:31,407 [salt.state       ][INFO    ][30658] Peering with localhost is not needed
2017-11-23 08:17:31,407 [salt.state       ][INFO    ][30658] Completed state [192.168.10.142] at time 08:17:31.407337 duration_in_ms=234.733
2017-11-23 08:17:31,411 [salt.state       ][INFO    ][30658] Running state [192.168.10.141] at time 08:17:31.410702
2017-11-23 08:17:31,411 [salt.state       ][INFO    ][30658] Executing state glusterfs.peered for 192.168.10.141
2017-11-23 08:17:31,411 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:31,419 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:31,470 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:31,478 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:31,535 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:31,544 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:31,594 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:31,602 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:31,654 [salt.state       ][INFO    ][30658] {'new': {'192.168.10.143': [], '192.168.10.141': []}, 'old': {'192.168.10.143': []}}
2017-11-23 08:17:31,654 [salt.state       ][INFO    ][30658] Completed state [192.168.10.141] at time 08:17:31.654246 duration_in_ms=243.544
2017-11-23 08:17:31,655 [salt.state       ][INFO    ][30658] Running state [glance] at time 08:17:31.655249
2017-11-23 08:17:31,656 [salt.state       ][INFO    ][30658] Executing state glusterfs.created for glance
2017-11-23 08:17:31,656 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:31,665 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:31,716 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:31,724 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:31,797 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:31,803 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:32,202 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:32,212 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:32,265 [salt.state       ][INFO    ][30658] {'new': ['glance'], 'old': []}
2017-11-23 08:17:32,265 [salt.state       ][INFO    ][30658] Completed state [glance] at time 08:17:32.265282 duration_in_ms=610.032
2017-11-23 08:17:32,269 [salt.state       ][INFO    ][30658] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 08:17:32.268933
2017-11-23 08:17:32,269 [salt.state       ][INFO    ][30658] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-11-23 08:17:32,270 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-23 08:17:32,320 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-11-23 08:17:32,411 [salt.state       ][INFO    ][30658] {'pid': 30880, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-23 08:17:32,411 [salt.state       ][INFO    ][30658] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 08:17:32.410834 duration_in_ms=141.901
2017-11-23 08:17:32,411 [salt.state       ][INFO    ][30658] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 08:17:32.411450
2017-11-23 08:17:32,412 [salt.state       ][INFO    ][30658] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-11-23 08:17:32,412 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-23 08:17:32,464 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume set 'glance' 'network.remote-dio' 'True'' in directory '/root'
2017-11-23 08:17:32,562 [salt.state       ][INFO    ][30658] {'pid': 30898, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-23 08:17:32,562 [salt.state       ][INFO    ][30658] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 08:17:32.562326 duration_in_ms=150.875
2017-11-23 08:17:32,563 [salt.state       ][INFO    ][30658] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 08:17:32.563032
2017-11-23 08:17:32,563 [salt.state       ][INFO    ][30658] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-11-23 08:17:32,564 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-11-23 08:17:32,614 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume set 'glance' 'nfs.disable' 'True'' in directory '/root'
2017-11-23 08:17:34,713 [salt.state       ][INFO    ][30658] {'pid': 30915, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-23 08:17:34,713 [salt.state       ][INFO    ][30658] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 08:17:34.713343 duration_in_ms=2150.309
2017-11-23 08:17:34,714 [salt.state       ][INFO    ][30658] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 08:17:34.713987
2017-11-23 08:17:34,714 [salt.state       ][INFO    ][30658] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-11-23 08:17:34,715 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-23 08:17:34,767 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-11-23 08:17:34,858 [salt.state       ][INFO    ][30658] {'pid': 30933, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-23 08:17:34,858 [salt.state       ][INFO    ][30658] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 08:17:34.857840 duration_in_ms=143.852
2017-11-23 08:17:34,858 [salt.state       ][INFO    ][30658] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 08:17:34.858432
2017-11-23 08:17:34,859 [salt.state       ][INFO    ][30658] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-11-23 08:17:34,859 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-23 08:17:34,911 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume set 'glance' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-11-23 08:17:34,997 [salt.state       ][INFO    ][30658] {'pid': 30950, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-23 08:17:34,998 [salt.state       ][INFO    ][30658] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 08:17:34.997605 duration_in_ms=139.171
2017-11-23 08:17:34,999 [salt.state       ][INFO    ][30658] Running state [glance] at time 08:17:34.998967
2017-11-23 08:17:34,999 [salt.state       ][INFO    ][30658] Executing state glusterfs.started for glance
2017-11-23 08:17:34,1000 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:35,008 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:35,059 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:35,069 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:35,126 [salt.state       ][INFO    ][30658] Volume glance is already started
2017-11-23 08:17:35,126 [salt.state       ][INFO    ][30658] Completed state [glance] at time 08:17:35.126442 duration_in_ms=127.475
2017-11-23 08:17:35,128 [salt.state       ][INFO    ][30658] Running state [keystone-keys] at time 08:17:35.127855
2017-11-23 08:17:35,128 [salt.state       ][INFO    ][30658] Executing state glusterfs.created for keystone-keys
2017-11-23 08:17:35,129 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:35,137 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:35,188 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:35,196 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:35,270 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:35,278 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:37,405 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:37,414 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:37,469 [salt.state       ][INFO    ][30658] {'new': ['glance', 'keystone-keys'], 'old': ['glance']}
2017-11-23 08:17:37,469 [salt.state       ][INFO    ][30658] Completed state [keystone-keys] at time 08:17:37.469436 duration_in_ms=2341.581
2017-11-23 08:17:37,475 [salt.state       ][INFO    ][30658] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 08:17:37.475006
2017-11-23 08:17:37,475 [salt.state       ][INFO    ][30658] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-11-23 08:17:37,476 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-23 08:17:37,528 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume set 'keystone-keys' 'network.remote-dio' 'True'' in directory '/root'
2017-11-23 08:17:37,628 [salt.state       ][INFO    ][30658] {'pid': 31064, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-23 08:17:37,629 [salt.state       ][INFO    ][30658] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 08:17:37.628646 duration_in_ms=153.638
2017-11-23 08:17:37,629 [salt.state       ][INFO    ][30658] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 08:17:37.629242
2017-11-23 08:17:37,630 [salt.state       ][INFO    ][30658] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-23 08:17:37,630 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-23 08:17:37,681 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-11-23 08:17:37,773 [salt.state       ][INFO    ][30658] {'pid': 31081, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-23 08:17:37,774 [salt.state       ][INFO    ][30658] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 08:17:37.773698 duration_in_ms=144.456
2017-11-23 08:17:37,774 [salt.state       ][INFO    ][30658] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 08:17:37.774293
2017-11-23 08:17:37,775 [salt.state       ][INFO    ][30658] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-23 08:17:37,775 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-23 08:17:37,826 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-11-23 08:17:38,003 [salt.state       ][INFO    ][30658] {'pid': 31099, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-23 08:17:38,004 [salt.state       ][INFO    ][30658] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 08:17:38.003594 duration_in_ms=229.3
2017-11-23 08:17:38,004 [salt.state       ][INFO    ][30658] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 08:17:38.004273
2017-11-23 08:17:38,005 [salt.state       ][INFO    ][30658] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-11-23 08:17:38,005 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-23 08:17:38,056 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume set 'keystone-keys' 'nfs.disable' 'True'' in directory '/root'
2017-11-23 08:17:39,376 [salt.minion      ][INFO    ][23545] User sudo_ubuntu Executing command saltutil.find_job with jid 20171123081739353017
2017-11-23 08:17:39,388 [salt.minion      ][INFO    ][31126] Starting a new job with PID 31126
2017-11-23 08:17:39,399 [salt.minion      ][INFO    ][31126] Returning information for job: 20171123081739353017
2017-11-23 08:17:40,158 [salt.state       ][INFO    ][30658] {'pid': 31116, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-23 08:17:40,159 [salt.state       ][INFO    ][30658] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 08:17:40.158535 duration_in_ms=2154.261
2017-11-23 08:17:40,159 [salt.state       ][INFO    ][30658] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 08:17:40.159155
2017-11-23 08:17:40,159 [salt.state       ][INFO    ][30658] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-11-23 08:17:40,160 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-23 08:17:40,214 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-11-23 08:17:40,307 [salt.state       ][INFO    ][30658] {'pid': 31138, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-23 08:17:40,307 [salt.state       ][INFO    ][30658] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 08:17:40.306816 duration_in_ms=147.659
2017-11-23 08:17:40,308 [salt.state       ][INFO    ][30658] Running state [keystone-keys] at time 08:17:40.308131
2017-11-23 08:17:40,308 [salt.state       ][INFO    ][30658] Executing state glusterfs.started for keystone-keys
2017-11-23 08:17:40,309 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:40,316 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:40,366 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:40,373 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:40,429 [salt.state       ][INFO    ][30658] Volume keystone-keys is already started
2017-11-23 08:17:40,430 [salt.state       ][INFO    ][30658] Completed state [keystone-keys] at time 08:17:40.429530 duration_in_ms=121.398
2017-11-23 08:17:40,431 [salt.state       ][INFO    ][30658] Running state [nova_instances] at time 08:17:40.430628
2017-11-23 08:17:40,431 [salt.state       ][INFO    ][30658] Executing state glusterfs.created for nova_instances
2017-11-23 08:17:40,431 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:40,439 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:40,490 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:40,498 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:40,571 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:40,579 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:42,712 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:42,722 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:42,774 [salt.state       ][INFO    ][30658] {'new': ['glance', 'keystone-keys', 'nova_instances'], 'old': ['glance', 'keystone-keys']}
2017-11-23 08:17:42,775 [salt.state       ][INFO    ][30658] Completed state [nova_instances] at time 08:17:42.774541 duration_in_ms=2343.911
2017-11-23 08:17:42,779 [salt.state       ][INFO    ][30658] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 08:17:42.778473
2017-11-23 08:17:42,779 [salt.state       ][INFO    ][30658] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-11-23 08:17:42,779 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-23 08:17:42,830 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-11-23 08:17:42,927 [salt.state       ][INFO    ][30658] {'pid': 31252, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-23 08:17:42,927 [salt.state       ][INFO    ][30658] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 08:17:42.927313 duration_in_ms=148.839
2017-11-23 08:17:42,928 [salt.state       ][INFO    ][30658] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 08:17:42.927936
2017-11-23 08:17:42,928 [salt.state       ][INFO    ][30658] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-11-23 08:17:42,929 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-11-23 08:17:42,980 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'' in directory '/root'
2017-11-23 08:17:43,080 [salt.state       ][INFO    ][30658] {'pid': 31270, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-23 08:17:43,080 [salt.state       ][INFO    ][30658] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 08:17:43.080042 duration_in_ms=152.106
2017-11-23 08:17:43,081 [salt.state       ][INFO    ][30658] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 08:17:43.080710
2017-11-23 08:17:43,081 [salt.state       ][INFO    ][30658] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-11-23 08:17:43,081 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-11-23 08:17:43,132 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume set 'nova_instances' 'network.remote-dio' 'On'' in directory '/root'
2017-11-23 08:17:43,231 [salt.state       ][INFO    ][30658] {'pid': 31287, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-23 08:17:43,231 [salt.state       ][INFO    ][30658] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 08:17:43.231319 duration_in_ms=150.609
2017-11-23 08:17:43,232 [salt.state       ][INFO    ][30658] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 08:17:43.231898
2017-11-23 08:17:43,232 [salt.state       ][INFO    ][30658] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-11-23 08:17:43,233 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-11-23 08:17:43,282 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume set 'nova_instances' 'nfs.disable' 'On'' in directory '/root'
2017-11-23 08:17:45,388 [salt.state       ][INFO    ][30658] {'pid': 31304, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-23 08:17:45,388 [salt.state       ][INFO    ][30658] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 08:17:45.388249 duration_in_ms=2156.35
2017-11-23 08:17:45,389 [salt.state       ][INFO    ][30658] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 08:17:45.388998
2017-11-23 08:17:45,389 [salt.state       ][INFO    ][30658] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-11-23 08:17:45,390 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-23 08:17:45,443 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-11-23 08:17:45,541 [salt.state       ][INFO    ][30658] {'pid': 31321, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-23 08:17:45,542 [salt.state       ][INFO    ][30658] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 08:17:45.541734 duration_in_ms=152.736
2017-11-23 08:17:45,543 [salt.state       ][INFO    ][30658] Running state [nova_instances] at time 08:17:45.543054
2017-11-23 08:17:45,543 [salt.state       ][INFO    ][30658] Executing state glusterfs.started for nova_instances
2017-11-23 08:17:45,544 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:45,551 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:45,603 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:45,611 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:45,666 [salt.state       ][INFO    ][30658] Volume nova_instances is already started
2017-11-23 08:17:45,667 [salt.state       ][INFO    ][30658] Completed state [nova_instances] at time 08:17:45.666531 duration_in_ms=123.477
2017-11-23 08:17:45,668 [salt.state       ][INFO    ][30658] Running state [keystone-credential-keys] at time 08:17:45.667619
2017-11-23 08:17:45,668 [salt.state       ][INFO    ][30658] Executing state glusterfs.created for keystone-credential-keys
2017-11-23 08:17:45,668 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:45,678 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:45,728 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:45,735 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:45,808 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:45,816 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:47,957 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:47,966 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:48,019 [salt.state       ][INFO    ][30658] {'new': ['glance', 'keystone-credential-keys', 'keystone-keys', 'nova_instances'], 'old': ['glance', 'keystone-keys', 'nova_instances']}
2017-11-23 08:17:48,019 [salt.state       ][INFO    ][30658] Completed state [keystone-credential-keys] at time 08:17:48.019010 duration_in_ms=2351.391
2017-11-23 08:17:48,023 [salt.state       ][INFO    ][30658] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 08:17:48.023086
2017-11-23 08:17:48,023 [salt.state       ][INFO    ][30658] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-11-23 08:17:48,024 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-23 08:17:48,075 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-11-23 08:17:48,181 [salt.state       ][INFO    ][30658] {'pid': 31439, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-23 08:17:48,182 [salt.state       ][INFO    ][30658] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 08:17:48.181441 duration_in_ms=158.353
2017-11-23 08:17:48,182 [salt.state       ][INFO    ][30658] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 08:17:48.182175
2017-11-23 08:17:48,183 [salt.state       ][INFO    ][30658] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-23 08:17:48,183 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-23 08:17:48,236 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-11-23 08:17:48,336 [salt.state       ][INFO    ][30658] {'pid': 31457, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-23 08:17:48,336 [salt.state       ][INFO    ][30658] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 08:17:48.336229 duration_in_ms=154.054
2017-11-23 08:17:48,337 [salt.state       ][INFO    ][30658] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 08:17:48.336923
2017-11-23 08:17:48,337 [salt.state       ][INFO    ][30658] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-11-23 08:17:48,338 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-23 08:17:48,392 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'' in directory '/root'
2017-11-23 08:17:49,531 [salt.minion      ][INFO    ][23545] User sudo_ubuntu Executing command saltutil.find_job with jid 20171123081749516563
2017-11-23 08:17:49,542 [salt.minion      ][INFO    ][31487] Starting a new job with PID 31487
2017-11-23 08:17:49,553 [salt.minion      ][INFO    ][31487] Returning information for job: 20171123081749516563
2017-11-23 08:17:50,502 [salt.state       ][INFO    ][30658] {'pid': 31475, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-23 08:17:50,503 [salt.state       ][INFO    ][30658] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 08:17:50.502436 duration_in_ms=2165.512
2017-11-23 08:17:50,503 [salt.state       ][INFO    ][30658] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 08:17:50.503213
2017-11-23 08:17:50,504 [salt.state       ][INFO    ][30658] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-23 08:17:50,504 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-23 08:17:50,558 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-11-23 08:17:50,653 [salt.state       ][INFO    ][30658] {'pid': 31499, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-23 08:17:50,653 [salt.state       ][INFO    ][30658] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 08:17:50.652837 duration_in_ms=149.625
2017-11-23 08:17:50,653 [salt.state       ][INFO    ][30658] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 08:17:50.653390
2017-11-23 08:17:50,654 [salt.state       ][INFO    ][30658] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-11-23 08:17:50,654 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-23 08:17:50,707 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'' in directory '/root'
2017-11-23 08:17:50,800 [salt.state       ][INFO    ][30658] {'pid': 31516, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-23 08:17:50,800 [salt.state       ][INFO    ][30658] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 08:17:50.800311 duration_in_ms=146.921
2017-11-23 08:17:50,802 [salt.state       ][INFO    ][30658] Running state [keystone-credential-keys] at time 08:17:50.801604
2017-11-23 08:17:50,802 [salt.state       ][INFO    ][30658] Executing state glusterfs.started for keystone-credential-keys
2017-11-23 08:17:50,802 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:50,811 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:50,862 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:17:50,870 [salt.loaded.int.module.cmdmod][INFO    ][30658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:17:50,927 [salt.state       ][INFO    ][30658] Volume keystone-credential-keys is already started
2017-11-23 08:17:50,927 [salt.state       ][INFO    ][30658] Completed state [keystone-credential-keys] at time 08:17:50.927108 duration_in_ms=125.503
2017-11-23 08:17:50,929 [salt.minion      ][INFO    ][30658] Returning information for job: 20171123081729296836
2017-11-23 08:18:02,410 [salt.minion      ][INFO    ][23545] User sudo_ubuntu Executing command test.ping with jid 20171123081802399861
2017-11-23 08:18:02,421 [salt.minion      ][INFO    ][31548] Starting a new job with PID 31548
2017-11-23 08:18:02,455 [salt.minion      ][INFO    ][31548] Returning information for job: 20171123081802399861
2017-11-23 08:18:02,597 [salt.minion      ][INFO    ][23545] User sudo_ubuntu Executing command cmd.run with jid 20171123081802580710
2017-11-23 08:18:02,606 [salt.minion      ][INFO    ][31554] Starting a new job with PID 31554
2017-11-23 08:18:02,610 [salt.loaded.int.module.cmdmod][INFO    ][31554] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-11-23 08:18:02,722 [salt.minion      ][INFO    ][31554] Returning information for job: 20171123081802580710
2017-11-23 08:55:14,915 [salt.utils.schedule][INFO    ][23545] Running scheduled job: __mine_interval
2017-11-23 08:57:37,065 [salt.minion      ][INFO    ][23545] User sudo_ubuntu Executing command test.ping with jid 20171123085737056710
2017-11-23 08:57:37,078 [salt.minion      ][INFO    ][32121] Starting a new job with PID 32121
2017-11-23 08:57:37,115 [salt.minion      ][INFO    ][32121] Returning information for job: 20171123085737056710
2017-11-23 08:57:56,431 [salt.minion      ][INFO    ][23545] User sudo_ubuntu Executing command state.sls with jid 20171123085756422959
2017-11-23 08:57:56,443 [salt.minion      ][INFO    ][32127] Starting a new job with PID 32127
2017-11-23 08:57:57,030 [salt.state       ][INFO    ][32127] Loading fresh modules for state activity
2017-11-23 08:57:57,063 [salt.fileclient  ][INFO    ][32127] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-11-23 08:57:57,084 [salt.fileclient  ][INFO    ][32127] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-11-23 08:57:57,111 [salt.fileclient  ][INFO    ][32127] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-23 08:57:57,404 [salt.state       ][INFO    ][32127] Running state [lsof] at time 08:57:57.403870
2017-11-23 08:57:57,404 [salt.state       ][INFO    ][32127] Executing state pkg.installed for lsof
2017-11-23 08:57:57,405 [salt.loaded.int.module.cmdmod][INFO    ][32127] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-23 08:57:57,668 [salt.state       ][INFO    ][32127] Package lsof is already installed
2017-11-23 08:57:57,668 [salt.state       ][INFO    ][32127] Completed state [lsof] at time 08:57:57.668356 duration_in_ms=264.485
2017-11-23 08:57:57,669 [salt.state       ][INFO    ][32127] Running state [keepalived] at time 08:57:57.668638
2017-11-23 08:57:57,669 [salt.state       ][INFO    ][32127] Executing state pkg.installed for keepalived
2017-11-23 08:57:57,673 [salt.state       ][INFO    ][32127] Package keepalived is already installed
2017-11-23 08:57:57,673 [salt.state       ][INFO    ][32127] Completed state [keepalived] at time 08:57:57.672695 duration_in_ms=4.057
2017-11-23 08:57:57,674 [salt.state       ][INFO    ][32127] Running state [/etc/keepalived/keepalived.conf] at time 08:57:57.674206
2017-11-23 08:57:57,674 [salt.state       ][INFO    ][32127] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-11-23 08:57:57,700 [salt.fileclient  ][INFO    ][32127] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-11-23 08:57:57,741 [salt.fileclient  ][INFO    ][32127] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-23 08:57:57,746 [salt.state       ][INFO    ][32127] File /etc/keepalived/keepalived.conf is in the correct state
2017-11-23 08:57:57,746 [salt.state       ][INFO    ][32127] Completed state [/etc/keepalived/keepalived.conf] at time 08:57:57.746138 duration_in_ms=71.932
2017-11-23 08:57:57,747 [salt.state       ][INFO    ][32127] Running state [keepalived] at time 08:57:57.746773
2017-11-23 08:57:57,747 [salt.state       ][INFO    ][32127] Executing state service.running for keepalived
2017-11-23 08:57:57,747 [salt.loaded.int.module.cmdmod][INFO    ][32127] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-11-23 08:57:57,760 [salt.loaded.int.module.cmdmod][INFO    ][32127] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-23 08:57:57,767 [salt.loaded.int.module.cmdmod][INFO    ][32127] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-23 08:57:57,774 [salt.state       ][INFO    ][32127] The service keepalived is already running
2017-11-23 08:57:57,775 [salt.state       ][INFO    ][32127] Completed state [keepalived] at time 08:57:57.774593 duration_in_ms=27.82
2017-11-23 08:57:57,775 [salt.minion      ][INFO    ][32127] Returning information for job: 20171123085756422959
2017-11-23 08:58:13,790 [salt.minion      ][INFO    ][23545] User sudo_ubuntu Executing command pillar.get with jid 20171123085813782368
2017-11-23 08:58:13,804 [salt.minion      ][INFO    ][32154] Starting a new job with PID 32154
2017-11-23 08:58:13,807 [salt.minion      ][INFO    ][32154] Returning information for job: 20171123085813782368
2017-11-23 08:58:57,267 [salt.minion      ][INFO    ][23545] User sudo_ubuntu Executing command state.sls with jid 20171123085857256282
2017-11-23 08:58:57,278 [salt.minion      ][INFO    ][32160] Starting a new job with PID 32160
2017-11-23 08:58:59,885 [salt.state       ][INFO    ][32160] Loading fresh modules for state activity
2017-11-23 08:58:59,912 [salt.fileclient  ][INFO    ][32160] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-23 08:58:59,936 [salt.fileclient  ][INFO    ][32160] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-23 08:59:00,240 [salt.state       ][INFO    ][32160] Running state [attr] at time 08:59:00.239520
2017-11-23 08:59:00,240 [salt.state       ][INFO    ][32160] Executing state pkg.installed for attr
2017-11-23 08:59:00,240 [salt.loaded.int.module.cmdmod][INFO    ][32160] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-23 08:59:00,501 [salt.state       ][INFO    ][32160] Package attr is already installed
2017-11-23 08:59:00,501 [salt.state       ][INFO    ][32160] Completed state [attr] at time 08:59:00.501407 duration_in_ms=261.888
2017-11-23 08:59:00,502 [salt.state       ][INFO    ][32160] Running state [glusterfs-server] at time 08:59:00.501633
2017-11-23 08:59:00,502 [salt.state       ][INFO    ][32160] Executing state pkg.installed for glusterfs-server
2017-11-23 08:59:00,506 [salt.state       ][INFO    ][32160] Package glusterfs-server is already installed
2017-11-23 08:59:00,506 [salt.state       ][INFO    ][32160] Completed state [glusterfs-server] at time 08:59:00.505650 duration_in_ms=4.017
2017-11-23 08:59:00,506 [salt.state       ][INFO    ][32160] Running state [bc] at time 08:59:00.505820
2017-11-23 08:59:00,506 [salt.state       ][INFO    ][32160] Executing state pkg.installed for bc
2017-11-23 08:59:00,510 [salt.state       ][INFO    ][32160] Package bc is already installed
2017-11-23 08:59:00,510 [salt.state       ][INFO    ][32160] Completed state [bc] at time 08:59:00.509715 duration_in_ms=3.895
2017-11-23 08:59:00,511 [salt.state       ][INFO    ][32160] Running state [glusterfs-server] at time 08:59:00.510502
2017-11-23 08:59:00,511 [salt.state       ][INFO    ][32160] Executing state service.running for glusterfs-server
2017-11-23 08:59:00,511 [salt.loaded.int.module.cmdmod][INFO    ][32160] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-23 08:59:00,527 [salt.loaded.int.module.cmdmod][INFO    ][32160] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-23 08:59:00,534 [salt.loaded.int.module.cmdmod][INFO    ][32160] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-23 08:59:00,542 [salt.state       ][INFO    ][32160] The service glusterfs-server is already running
2017-11-23 08:59:00,542 [salt.state       ][INFO    ][32160] Completed state [glusterfs-server] at time 08:59:00.541818 duration_in_ms=31.315
2017-11-23 08:59:00,543 [salt.state       ][INFO    ][32160] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 08:59:00.543374
2017-11-23 08:59:00,544 [salt.state       ][INFO    ][32160] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-23 08:59:00,546 [salt.state       ][INFO    ][32160] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-23 08:59:00,546 [salt.state       ][INFO    ][32160] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 08:59:00.545826 duration_in_ms=2.451
2017-11-23 08:59:00,546 [salt.state       ][INFO    ][32160] Running state [/srv/glusterfs/glance] at time 08:59:00.546028
2017-11-23 08:59:00,546 [salt.state       ][INFO    ][32160] Executing state file.directory for /srv/glusterfs/glance
2017-11-23 08:59:00,547 [salt.state       ][INFO    ][32160] Directory /srv/glusterfs/glance is in the correct state
2017-11-23 08:59:00,547 [salt.state       ][INFO    ][32160] Completed state [/srv/glusterfs/glance] at time 08:59:00.546791 duration_in_ms=0.763
2017-11-23 08:59:00,547 [salt.state       ][INFO    ][32160] Running state [/srv/glusterfs/keystone-keys] at time 08:59:00.546974
2017-11-23 08:59:00,547 [salt.state       ][INFO    ][32160] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-23 08:59:00,548 [salt.state       ][INFO    ][32160] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-23 08:59:00,548 [salt.state       ][INFO    ][32160] Completed state [/srv/glusterfs/keystone-keys] at time 08:59:00.547727 duration_in_ms=0.753
2017-11-23 08:59:00,548 [salt.state       ][INFO    ][32160] Running state [/srv/glusterfs/nova_instances] at time 08:59:00.547902
2017-11-23 08:59:00,548 [salt.state       ][INFO    ][32160] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-23 08:59:00,548 [salt.state       ][INFO    ][32160] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-23 08:59:00,549 [salt.state       ][INFO    ][32160] Completed state [/srv/glusterfs/nova_instances] at time 08:59:00.548629 duration_in_ms=0.726
2017-11-23 08:59:00,549 [salt.state       ][INFO    ][32160] Running state [/srv/glusterfs/keystone-credential-keys] at time 08:59:00.548805
2017-11-23 08:59:00,549 [salt.state       ][INFO    ][32160] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-23 08:59:00,549 [salt.state       ][INFO    ][32160] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-23 08:59:00,550 [salt.state       ][INFO    ][32160] Completed state [/srv/glusterfs/keystone-credential-keys] at time 08:59:00.549528 duration_in_ms=0.722
2017-11-23 08:59:00,550 [salt.minion      ][INFO    ][32160] Returning information for job: 20171123085857256282
2017-11-23 08:59:01,587 [salt.minion      ][INFO    ][23545] User sudo_ubuntu Executing command test.ping with jid 20171123085901578645
2017-11-23 08:59:01,599 [salt.minion      ][INFO    ][32183] Starting a new job with PID 32183
2017-11-23 08:59:01,634 [salt.minion      ][INFO    ][32183] Returning information for job: 20171123085901578645
2017-11-23 08:59:01,760 [salt.minion      ][INFO    ][23545] User sudo_ubuntu Executing command state.sls with jid 20171123085901751152
2017-11-23 08:59:01,771 [salt.minion      ][INFO    ][32188] Starting a new job with PID 32188
2017-11-23 08:59:02,351 [salt.state       ][INFO    ][32188] Loading fresh modules for state activity
2017-11-23 08:59:02,381 [salt.fileclient  ][INFO    ][32188] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-11-23 08:59:02,428 [salt.fileclient  ][INFO    ][32188] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-23 08:59:02,511 [salt.fileclient  ][INFO    ][32188] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-23 08:59:02,537 [salt.fileclient  ][INFO    ][32188] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-23 08:59:02,855 [salt.state       ][INFO    ][32188] Running state [attr] at time 08:59:02.855239
2017-11-23 08:59:02,856 [salt.state       ][INFO    ][32188] Executing state pkg.installed for attr
2017-11-23 08:59:02,856 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-23 08:59:03,152 [salt.state       ][INFO    ][32188] Package attr is already installed
2017-11-23 08:59:03,153 [salt.state       ][INFO    ][32188] Completed state [attr] at time 08:59:03.152535 duration_in_ms=297.295
2017-11-23 08:59:03,153 [salt.state       ][INFO    ][32188] Running state [glusterfs-server] at time 08:59:03.152803
2017-11-23 08:59:03,153 [salt.state       ][INFO    ][32188] Executing state pkg.installed for glusterfs-server
2017-11-23 08:59:03,157 [salt.state       ][INFO    ][32188] Package glusterfs-server is already installed
2017-11-23 08:59:03,157 [salt.state       ][INFO    ][32188] Completed state [glusterfs-server] at time 08:59:03.157076 duration_in_ms=4.273
2017-11-23 08:59:03,157 [salt.state       ][INFO    ][32188] Running state [bc] at time 08:59:03.157268
2017-11-23 08:59:03,157 [salt.state       ][INFO    ][32188] Executing state pkg.installed for bc
2017-11-23 08:59:03,161 [salt.state       ][INFO    ][32188] Package bc is already installed
2017-11-23 08:59:03,161 [salt.state       ][INFO    ][32188] Completed state [bc] at time 08:59:03.161342 duration_in_ms=4.074
2017-11-23 08:59:03,162 [salt.state       ][INFO    ][32188] Running state [glusterfs-server] at time 08:59:03.162400
2017-11-23 08:59:03,163 [salt.state       ][INFO    ][32188] Executing state service.running for glusterfs-server
2017-11-23 08:59:03,163 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-23 08:59:03,178 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-23 08:59:03,184 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-23 08:59:03,193 [salt.state       ][INFO    ][32188] The service glusterfs-server is already running
2017-11-23 08:59:03,194 [salt.state       ][INFO    ][32188] Completed state [glusterfs-server] at time 08:59:03.193659 duration_in_ms=31.258
2017-11-23 08:59:03,195 [salt.state       ][INFO    ][32188] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 08:59:03.195167
2017-11-23 08:59:03,195 [salt.state       ][INFO    ][32188] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-23 08:59:03,198 [salt.state       ][INFO    ][32188] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-23 08:59:03,198 [salt.state       ][INFO    ][32188] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 08:59:03.197688 duration_in_ms=2.521
2017-11-23 08:59:03,198 [salt.state       ][INFO    ][32188] Running state [/srv/glusterfs/glance] at time 08:59:03.197926
2017-11-23 08:59:03,198 [salt.state       ][INFO    ][32188] Executing state file.directory for /srv/glusterfs/glance
2017-11-23 08:59:03,199 [salt.state       ][INFO    ][32188] Directory /srv/glusterfs/glance is in the correct state
2017-11-23 08:59:03,199 [salt.state       ][INFO    ][32188] Completed state [/srv/glusterfs/glance] at time 08:59:03.198803 duration_in_ms=0.877
2017-11-23 08:59:03,199 [salt.state       ][INFO    ][32188] Running state [/srv/glusterfs/keystone-keys] at time 08:59:03.198985
2017-11-23 08:59:03,199 [salt.state       ][INFO    ][32188] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-23 08:59:03,200 [salt.state       ][INFO    ][32188] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-23 08:59:03,200 [salt.state       ][INFO    ][32188] Completed state [/srv/glusterfs/keystone-keys] at time 08:59:03.199771 duration_in_ms=0.785
2017-11-23 08:59:03,200 [salt.state       ][INFO    ][32188] Running state [/srv/glusterfs/nova_instances] at time 08:59:03.199952
2017-11-23 08:59:03,200 [salt.state       ][INFO    ][32188] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-23 08:59:03,201 [salt.state       ][INFO    ][32188] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-23 08:59:03,201 [salt.state       ][INFO    ][32188] Completed state [/srv/glusterfs/nova_instances] at time 08:59:03.200731 duration_in_ms=0.779
2017-11-23 08:59:03,201 [salt.state       ][INFO    ][32188] Running state [/srv/glusterfs/keystone-credential-keys] at time 08:59:03.200916
2017-11-23 08:59:03,201 [salt.state       ][INFO    ][32188] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-23 08:59:03,202 [salt.state       ][INFO    ][32188] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-23 08:59:03,202 [salt.state       ][INFO    ][32188] Completed state [/srv/glusterfs/keystone-credential-keys] at time 08:59:03.201681 duration_in_ms=0.765
2017-11-23 08:59:03,281 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command ['git', '--version'] in directory '/root'
2017-11-23 08:59:03,329 [salt.state       ][INFO    ][32188] Running state [sleep 5] at time 08:59:03.328803
2017-11-23 08:59:03,329 [salt.state       ][INFO    ][32188] Executing state cmd.wait for sleep 5
2017-11-23 08:59:03,329 [salt.state       ][INFO    ][32188] No changes made for sleep 5
2017-11-23 08:59:03,330 [salt.state       ][INFO    ][32188] Completed state [sleep 5] at time 08:59:03.329544 duration_in_ms=0.742
2017-11-23 08:59:03,330 [salt.state       ][INFO    ][32188] Running state [192.168.10.143] at time 08:59:03.330134
2017-11-23 08:59:03,330 [salt.state       ][INFO    ][32188] Executing state glusterfs.peered for 192.168.10.143
2017-11-23 08:59:03,331 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:03,339 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:03,391 [salt.state       ][INFO    ][32188] Host 192.168.10.143 already peered
2017-11-23 08:59:03,391 [salt.state       ][INFO    ][32188] Completed state [192.168.10.143] at time 08:59:03.391187 duration_in_ms=61.053
2017-11-23 08:59:03,394 [salt.state       ][INFO    ][32188] Running state [192.168.10.142] at time 08:59:03.394144
2017-11-23 08:59:03,394 [salt.state       ][INFO    ][32188] Executing state glusterfs.peered for 192.168.10.142
2017-11-23 08:59:03,395 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:03,404 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:03,455 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:03,463 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:03,514 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:03,522 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:03,575 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:03,583 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:03,637 [salt.state       ][INFO    ][32188] Peering with localhost is not needed
2017-11-23 08:59:03,637 [salt.state       ][INFO    ][32188] Completed state [192.168.10.142] at time 08:59:03.636814 duration_in_ms=242.669
2017-11-23 08:59:03,640 [salt.state       ][INFO    ][32188] Running state [192.168.10.141] at time 08:59:03.639857
2017-11-23 08:59:03,640 [salt.state       ][INFO    ][32188] Executing state glusterfs.peered for 192.168.10.141
2017-11-23 08:59:03,641 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:03,649 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:03,702 [salt.state       ][INFO    ][32188] Host 192.168.10.141 already peered
2017-11-23 08:59:03,702 [salt.state       ][INFO    ][32188] Completed state [192.168.10.141] at time 08:59:03.702111 duration_in_ms=62.253
2017-11-23 08:59:03,703 [salt.state       ][INFO    ][32188] Running state [glance] at time 08:59:03.703227
2017-11-23 08:59:03,704 [salt.state       ][INFO    ][32188] Executing state glusterfs.created for glance
2017-11-23 08:59:03,704 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:03,712 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:03,764 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:03,771 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:03,827 [salt.state       ][INFO    ][32188] Volume glance already exists and is started.
2017-11-23 08:59:03,827 [salt.state       ][INFO    ][32188] Completed state [glance] at time 08:59:03.826775 duration_in_ms=123.548
2017-11-23 08:59:03,830 [salt.state       ][INFO    ][32188] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 08:59:03.830314
2017-11-23 08:59:03,831 [salt.state       ][INFO    ][32188] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-11-23 08:59:03,831 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-23 08:59:03,881 [salt.state       ][INFO    ][32188] unless execution succeeded
2017-11-23 08:59:03,882 [salt.state       ][INFO    ][32188] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 08:59:03.881710 duration_in_ms=51.396
2017-11-23 08:59:03,882 [salt.state       ][INFO    ][32188] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 08:59:03.882304
2017-11-23 08:59:03,883 [salt.state       ][INFO    ][32188] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-11-23 08:59:03,883 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-23 08:59:03,935 [salt.state       ][INFO    ][32188] unless execution succeeded
2017-11-23 08:59:03,935 [salt.state       ][INFO    ][32188] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 08:59:03.935152 duration_in_ms=52.848
2017-11-23 08:59:03,936 [salt.state       ][INFO    ][32188] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 08:59:03.935692
2017-11-23 08:59:03,936 [salt.state       ][INFO    ][32188] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-11-23 08:59:03,936 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-11-23 08:59:03,987 [salt.state       ][INFO    ][32188] unless execution succeeded
2017-11-23 08:59:03,987 [salt.state       ][INFO    ][32188] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 08:59:03.987070 duration_in_ms=51.377
2017-11-23 08:59:03,988 [salt.state       ][INFO    ][32188] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 08:59:03.987693
2017-11-23 08:59:03,988 [salt.state       ][INFO    ][32188] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-11-23 08:59:03,988 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-23 08:59:04,038 [salt.state       ][INFO    ][32188] unless execution succeeded
2017-11-23 08:59:04,038 [salt.state       ][INFO    ][32188] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 08:59:04.037966 duration_in_ms=50.272
2017-11-23 08:59:04,039 [salt.state       ][INFO    ][32188] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 08:59:04.038551
2017-11-23 08:59:04,039 [salt.state       ][INFO    ][32188] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-11-23 08:59:04,039 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-23 08:59:04,093 [salt.state       ][INFO    ][32188] unless execution succeeded
2017-11-23 08:59:04,093 [salt.state       ][INFO    ][32188] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 08:59:04.092809 duration_in_ms=54.257
2017-11-23 08:59:04,094 [salt.state       ][INFO    ][32188] Running state [glance] at time 08:59:04.094081
2017-11-23 08:59:04,094 [salt.state       ][INFO    ][32188] Executing state glusterfs.started for glance
2017-11-23 08:59:04,095 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:04,103 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:04,154 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:04,162 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:04,219 [salt.state       ][INFO    ][32188] Volume glance is already started
2017-11-23 08:59:04,219 [salt.state       ][INFO    ][32188] Completed state [glance] at time 08:59:04.218962 duration_in_ms=124.881
2017-11-23 08:59:04,220 [salt.state       ][INFO    ][32188] Running state [keystone-keys] at time 08:59:04.219963
2017-11-23 08:59:04,220 [salt.state       ][INFO    ][32188] Executing state glusterfs.created for keystone-keys
2017-11-23 08:59:04,221 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:04,229 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:04,281 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:04,289 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:04,343 [salt.state       ][INFO    ][32188] Volume keystone-keys already exists and is started.
2017-11-23 08:59:04,344 [salt.state       ][INFO    ][32188] Completed state [keystone-keys] at time 08:59:04.343710 duration_in_ms=123.747
2017-11-23 08:59:04,352 [salt.state       ][INFO    ][32188] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 08:59:04.351614
2017-11-23 08:59:04,353 [salt.state       ][INFO    ][32188] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-11-23 08:59:04,354 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-23 08:59:04,406 [salt.state       ][INFO    ][32188] unless execution succeeded
2017-11-23 08:59:04,406 [salt.state       ][INFO    ][32188] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 08:59:04.406374 duration_in_ms=54.756
2017-11-23 08:59:04,407 [salt.state       ][INFO    ][32188] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 08:59:04.407024
2017-11-23 08:59:04,407 [salt.state       ][INFO    ][32188] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-23 08:59:04,408 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-23 08:59:04,461 [salt.state       ][INFO    ][32188] unless execution succeeded
2017-11-23 08:59:04,462 [salt.state       ][INFO    ][32188] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 08:59:04.461713 duration_in_ms=54.687
2017-11-23 08:59:04,462 [salt.state       ][INFO    ][32188] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 08:59:04.462339
2017-11-23 08:59:04,463 [salt.state       ][INFO    ][32188] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-23 08:59:04,463 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-23 08:59:04,516 [salt.state       ][INFO    ][32188] unless execution succeeded
2017-11-23 08:59:04,516 [salt.state       ][INFO    ][32188] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 08:59:04.516372 duration_in_ms=54.033
2017-11-23 08:59:04,517 [salt.state       ][INFO    ][32188] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 08:59:04.516972
2017-11-23 08:59:04,517 [salt.state       ][INFO    ][32188] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-11-23 08:59:04,518 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-23 08:59:04,571 [salt.state       ][INFO    ][32188] unless execution succeeded
2017-11-23 08:59:04,571 [salt.state       ][INFO    ][32188] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 08:59:04.570973 duration_in_ms=54.001
2017-11-23 08:59:04,572 [salt.state       ][INFO    ][32188] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 08:59:04.571707
2017-11-23 08:59:04,572 [salt.state       ][INFO    ][32188] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-11-23 08:59:04,573 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-23 08:59:04,626 [salt.state       ][INFO    ][32188] unless execution succeeded
2017-11-23 08:59:04,626 [salt.state       ][INFO    ][32188] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 08:59:04.626092 duration_in_ms=54.384
2017-11-23 08:59:04,628 [salt.state       ][INFO    ][32188] Running state [keystone-keys] at time 08:59:04.627524
2017-11-23 08:59:04,628 [salt.state       ][INFO    ][32188] Executing state glusterfs.started for keystone-keys
2017-11-23 08:59:04,629 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:04,637 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:04,689 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:04,697 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:04,753 [salt.state       ][INFO    ][32188] Volume keystone-keys is already started
2017-11-23 08:59:04,753 [salt.state       ][INFO    ][32188] Completed state [keystone-keys] at time 08:59:04.752868 duration_in_ms=125.344
2017-11-23 08:59:04,754 [salt.state       ][INFO    ][32188] Running state [nova_instances] at time 08:59:04.753993
2017-11-23 08:59:04,754 [salt.state       ][INFO    ][32188] Executing state glusterfs.created for nova_instances
2017-11-23 08:59:04,755 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:04,762 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:04,813 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:04,821 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:04,877 [salt.state       ][INFO    ][32188] Volume nova_instances already exists and is started.
2017-11-23 08:59:04,878 [salt.state       ][INFO    ][32188] Completed state [nova_instances] at time 08:59:04.877617 duration_in_ms=123.624
2017-11-23 08:59:04,882 [salt.state       ][INFO    ][32188] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 08:59:04.881633
2017-11-23 08:59:04,882 [salt.state       ][INFO    ][32188] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-11-23 08:59:04,882 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-23 08:59:04,934 [salt.state       ][INFO    ][32188] unless execution succeeded
2017-11-23 08:59:04,934 [salt.state       ][INFO    ][32188] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 08:59:04.934395 duration_in_ms=52.762
2017-11-23 08:59:04,935 [salt.state       ][INFO    ][32188] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 08:59:04.935067
2017-11-23 08:59:04,935 [salt.state       ][INFO    ][32188] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-11-23 08:59:04,936 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-11-23 08:59:04,988 [salt.state       ][INFO    ][32188] unless execution succeeded
2017-11-23 08:59:04,988 [salt.state       ][INFO    ][32188] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 08:59:04.987806 duration_in_ms=52.738
2017-11-23 08:59:04,989 [salt.state       ][INFO    ][32188] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 08:59:04.988464
2017-11-23 08:59:04,989 [salt.state       ][INFO    ][32188] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-11-23 08:59:04,989 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-11-23 08:59:05,041 [salt.state       ][INFO    ][32188] unless execution succeeded
2017-11-23 08:59:05,041 [salt.state       ][INFO    ][32188] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 08:59:05.040923 duration_in_ms=52.459
2017-11-23 08:59:05,042 [salt.state       ][INFO    ][32188] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 08:59:05.041555
2017-11-23 08:59:05,042 [salt.state       ][INFO    ][32188] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-11-23 08:59:05,042 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-11-23 08:59:05,091 [salt.state       ][INFO    ][32188] unless execution succeeded
2017-11-23 08:59:05,092 [salt.state       ][INFO    ][32188] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 08:59:05.091659 duration_in_ms=50.103
2017-11-23 08:59:05,093 [salt.state       ][INFO    ][32188] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 08:59:05.092466
2017-11-23 08:59:05,093 [salt.state       ][INFO    ][32188] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-11-23 08:59:05,093 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-23 08:59:05,146 [salt.state       ][INFO    ][32188] unless execution succeeded
2017-11-23 08:59:05,146 [salt.state       ][INFO    ][32188] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 08:59:05.146005 duration_in_ms=53.538
2017-11-23 08:59:05,147 [salt.state       ][INFO    ][32188] Running state [nova_instances] at time 08:59:05.147280
2017-11-23 08:59:05,148 [salt.state       ][INFO    ][32188] Executing state glusterfs.started for nova_instances
2017-11-23 08:59:05,148 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:05,155 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:05,206 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:05,214 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:05,269 [salt.state       ][INFO    ][32188] Volume nova_instances is already started
2017-11-23 08:59:05,269 [salt.state       ][INFO    ][32188] Completed state [nova_instances] at time 08:59:05.268971 duration_in_ms=121.69
2017-11-23 08:59:05,270 [salt.state       ][INFO    ][32188] Running state [keystone-credential-keys] at time 08:59:05.270111
2017-11-23 08:59:05,270 [salt.state       ][INFO    ][32188] Executing state glusterfs.created for keystone-credential-keys
2017-11-23 08:59:05,271 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:05,278 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:05,331 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:05,339 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:05,394 [salt.state       ][INFO    ][32188] Volume keystone-credential-keys already exists and is started.
2017-11-23 08:59:05,394 [salt.state       ][INFO    ][32188] Completed state [keystone-credential-keys] at time 08:59:05.394018 duration_in_ms=123.894
2017-11-23 08:59:05,398 [salt.state       ][INFO    ][32188] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 08:59:05.398167
2017-11-23 08:59:05,398 [salt.state       ][INFO    ][32188] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-11-23 08:59:05,399 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-23 08:59:05,452 [salt.state       ][INFO    ][32188] unless execution succeeded
2017-11-23 08:59:05,452 [salt.state       ][INFO    ][32188] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 08:59:05.451854 duration_in_ms=53.687
2017-11-23 08:59:05,452 [salt.state       ][INFO    ][32188] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 08:59:05.452419
2017-11-23 08:59:05,453 [salt.state       ][INFO    ][32188] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-23 08:59:05,453 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-23 08:59:05,505 [salt.state       ][INFO    ][32188] unless execution succeeded
2017-11-23 08:59:05,506 [salt.state       ][INFO    ][32188] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 08:59:05.505748 duration_in_ms=53.328
2017-11-23 08:59:05,507 [salt.state       ][INFO    ][32188] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 08:59:05.506469
2017-11-23 08:59:05,507 [salt.state       ][INFO    ][32188] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-11-23 08:59:05,507 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-23 08:59:05,559 [salt.state       ][INFO    ][32188] unless execution succeeded
2017-11-23 08:59:05,559 [salt.state       ][INFO    ][32188] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 08:59:05.559098 duration_in_ms=52.629
2017-11-23 08:59:05,560 [salt.state       ][INFO    ][32188] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 08:59:05.559790
2017-11-23 08:59:05,560 [salt.state       ][INFO    ][32188] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-23 08:59:05,561 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-23 08:59:05,612 [salt.state       ][INFO    ][32188] unless execution succeeded
2017-11-23 08:59:05,612 [salt.state       ][INFO    ][32188] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 08:59:05.612352 duration_in_ms=52.561
2017-11-23 08:59:05,613 [salt.state       ][INFO    ][32188] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 08:59:05.612925
2017-11-23 08:59:05,613 [salt.state       ][INFO    ][32188] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-11-23 08:59:05,614 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-23 08:59:05,665 [salt.state       ][INFO    ][32188] unless execution succeeded
2017-11-23 08:59:05,665 [salt.state       ][INFO    ][32188] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 08:59:05.664899 duration_in_ms=51.974
2017-11-23 08:59:05,666 [salt.state       ][INFO    ][32188] Running state [keystone-credential-keys] at time 08:59:05.666206
2017-11-23 08:59:05,666 [salt.state       ][INFO    ][32188] Executing state glusterfs.started for keystone-credential-keys
2017-11-23 08:59:05,667 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:05,675 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:05,727 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --version' in directory '/root'
2017-11-23 08:59:05,735 [salt.loaded.int.module.cmdmod][INFO    ][32188] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-23 08:59:05,792 [salt.state       ][INFO    ][32188] Volume keystone-credential-keys is already started
2017-11-23 08:59:05,792 [salt.state       ][INFO    ][32188] Completed state [keystone-credential-keys] at time 08:59:05.792250 duration_in_ms=126.042
2017-11-23 08:59:05,795 [salt.minion      ][INFO    ][32188] Returning information for job: 20171123085901751152
2017-11-23 08:59:15,251 [salt.minion      ][INFO    ][23545] User sudo_ubuntu Executing command test.ping with jid 20171123085915241600
2017-11-23 08:59:15,263 [salt.minion      ][INFO    ][32572] Starting a new job with PID 32572
2017-11-23 08:59:15,297 [salt.minion      ][INFO    ][32572] Returning information for job: 20171123085915241600
2017-11-23 08:59:15,427 [salt.minion      ][INFO    ][23545] User sudo_ubuntu Executing command cmd.run with jid 20171123085915417175
2017-11-23 08:59:15,437 [salt.minion      ][INFO    ][32577] Starting a new job with PID 32577
2017-11-23 08:59:15,442 [salt.loaded.int.module.cmdmod][INFO    ][32577] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-11-23 08:59:15,560 [salt.minion      ][INFO    ][32577] Returning information for job: 20171123085915417175
2017-11-23 09:23:01,192 [salt.minion      ][INFO    ][23545] User sudo_ubuntu Executing command cp.push_dir with jid 20171123092301171265
2017-11-23 09:23:01,205 [salt.minion      ][INFO    ][32769] Starting a new job with PID 32769
